-- Log file for all dbTracef messages --

13:50:24.79   NetworkManager::Create - creating network manager
13:50:24.79   Read 269 bytes from network datastore login_cache.bin
13:50:24.79   Read 52 bytes from network datastore global_cache.bin
13:50:24.79   Read 28 bytes from network datastore ping_cache.bin
13:50:24.79   QuazalInitializer - static initializing Quazal library
13:50:24.79   PingCache - populating cache with 0 pings
13:50:24.79   Sent message game CompanyOfHeroes started 2800 602 allowtraffic
13:50:24.79   RemoteDLManager - Connection Restored.
13:50:24.79   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
13:50:24.84   WinTransport - CreateSocket exclusive broadcast socket was available.
13:50:24.84   WinTransport - CreateSocket listening for broadcasts on default port
13:50:24.84   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
13:50:24.84   WinTransport - Host IP Address #0: 127.0.0.1
13:50:24.84   WinTransport - Interface #0: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
13:50:24.84   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
13:50:24.84   WinTransport - Quazal address string = udp:/address=127.0.0.1;port=6112
13:50:24.84   SessionManager - Peer Header Size = 16 bytes
13:50:24.84   SessionManager - Game Data overhead = 7 bytes
13:50:24.84   SessionManager - Proxy overhead = 7 bytes
13:50:24.84   MessageInternal::CreateChannel: Created channel 47535450
13:50:24.84   Session::Initialize - info, initializing session object, using threads.
13:50:24.84   SessionManager::RegisterSession - Registering new session 03b05ff8
13:50:24.84   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
13:50:24.84   AutomatchInternal: Instantiating
13:50:24.84   PartyInternal: Instantiating
13:50:24.84   MessageInternal::CreateChannel: Created channel 50525459
13:50:24.84   MessageInternal::CreateChannel: Created channel 51434b4d
13:50:24.84   Net::ThreadFunction - Entering network thread function...
13:50:24.85   MessageInternal::CreateChannel: Created channel 534d5347
13:50:24.85   MessageInternal::CreateChannel: Created channel 474d4343
13:50:24.85   MessageInternal::CreateChannel: Created channel 474f424a
13:50:24.85   MessageInternal::CreateChannel: Created channel 4d4f444d
13:50:24.85   MessageInternal::CreateChannel: Created channel 53594e43
13:50:24.85   MessageInternal::DestroyChannel: Destroyed channel 534d5347
13:50:24.85   MessageInternal::DestroyChannel: Destroyed channel 474d4343
13:50:24.85   MessageInternal::DestroyChannel: Destroyed channel 474f424a
13:50:24.85   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
13:50:24.85   MessageInternal::DestroyChannel: Destroyed channel 53594e43
13:50:24.85   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
13:50:24.86   Transport - Largest received is now 19
13:50:24.86   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
13:50:28.24   DLLDriverLinker -- Adding driver 'spDx10.dll'.
13:50:28.25   DLLDriverLinker -- Adding driver 'spDx9.dll'.
13:50:28.25   DLLDriverLinker -- 2 DLL drivers found.
13:50:28.30   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
13:50:30.07   DLLDriverLinker -- 2 DLL drivers found.
13:50:30.22   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
13:50:30.22   GAME -- Resolution set to 1024x768 (fullscreen).
13:50:30.23   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
13:50:30.23   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
13:50:30.23   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
13:50:30.23   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
13:50:30.77   SPDx9 -- 1774MB available Texture Memory
13:50:30.77   ShaderDatabase: using shader profile [ps30]
13:50:31.34   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
13:50:31.60   GameObjLoader 5078e4b8 - resetting counters
13:50:31.60   GameObjLoader 5078e4b8 - Created loader
13:50:31.60   GameObjLoader 5078e618 - resetting counters
13:50:31.60   GameObjLoader 5078e618 - Created loader
13:50:31.91   GAME -- Beginning FE
13:50:31.91   Sent message game CompanyOfHeroes allowtraffic
13:50:31.91   UIFrontEnd - Loading Front End
13:50:31.91   THREAD: Hyper-Threading Technology Processors are not detected.
13:50:31.99   SOUND -- Initializing ...
13:50:32.73   SOUND -- Initialization completed!
13:50:32.73   UIFrontEnd - Initializing Forms
13:50:34.71   CampaignFilter::BindFilterSpecificWidgets()
13:50:34.78   installed_products = ( )
13:50:34.81   Activating screen: AppLoadingForm
13:50:34.81   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
13:50:34.81   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
13:50:34.81   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
13:50:34.81   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
13:50:35.62   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
13:50:35.62   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
13:50:35.62   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
13:50:35.62   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
13:50:35.63   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
13:50:35.63   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
13:50:36.01   GAME -- Using player profile NGOCQUANG-PC
13:50:39.36   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
13:50:40.32   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
13:50:41.42   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
13:50:41.42   RendezvousManager: CreateSession - starting profile=Guest login
13:50:41.47   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
13:50:41.47   RendezvousManager - unable to connect to the server as guest
13:50:41.48   OnConnect: connect failure
13:50:41.48   RendezvousManager::Shutdown - deleting instance
13:50:41.48   RendezvousManager - terminating all server calls in progress
13:50:41.48   CallManager - terminating all server calls in progress (1 in progress)
13:50:41.48   RendezvousManager - destroying chat handler
13:50:41.48   ~RendezvousManager - m_state = 7, no need for server disconnect
13:50:41.50   OnConnect: this wasnt a reconnect, no need for autologin
13:50:41.52   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
13:50:41.52   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
13:50:41.52   Activating screen: FEMovie
13:50:41.52   Activating screen: OnlineWidget
13:50:41.52   Activating screen: RelicOnlineLogin
13:50:41.58   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
13:50:41.58   You have a valid version of the game.
13:50:41.59   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
13:50:41.59   installed_products = ( DLC1 DLC2 DLC3 )
13:50:41.59   OnLogin: no previous login, auto selecting profile not required
13:50:41.59   Activating screen: MessageBoxPopup
13:50:41.59   Activating screen: MessageBoxPopup
13:50:41.59   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
13:50:50.12   Beginning media verification...
13:50:50.12   Validator type : validators\udro\udro.dll
13:50:50.12   Activating screen: MessageBoxPopup
13:50:52.42   Activating screen: FE_mm_01
13:50:52.43   GAME -- Setting campaign state to 'dlc1'
13:50:52.43   GAME -- Closing state 'dlc1'
13:50:52.44   GAME -- Setting campaign state to 'dlc2'
13:50:52.44   GAME -- Closing state 'dlc2'
13:50:52.44   GAME -- Setting campaign state to 'dlc3'
13:50:52.44   GAME -- Closing state 'dlc3'
13:51:01.34   FEHelpers::DoScenarioSelection - Could not find current profile, using first scenario
13:51:01.34   Activating screen: MessageBoxPopup
13:51:01.34   Created Matchinfo
13:51:01.34   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
13:51:01.35   starting LAN hosting
13:51:01.38   OnJoinAdvertisementSuccess - joined online match, server leave notification required
13:51:01.38   starting local hosting
13:51:01.38   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
13:51:01.38   Allocated route ID=0 for PeerID 1 at WINaddr:127.0.0.1:6112;
13:51:01.38   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
13:51:01.38   Session::Host sid = C2BE6DE3E130CA60, hostURL = , local addresses = WINaddr:127.0.0.1:6112;
13:51:01.38   ValidateCustomData: called with 217 bytes of custom data
13:51:01.38   Host accepted Peer 1 into the match at address list=WINaddr:127.0.0.1:6112;, routes=WINaddr:127.0.0.1:6112;
13:51:01.38   AdvertisementInternal::Process - EVENT_NEWPEER
13:51:01.38   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
13:51:01.39   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
13:51:01.39   hosting - Session is connected
13:51:01.39   Net::Session::SetVisible - session is set to VISIBLE.
13:51:01.41   hosting completed successfully
13:51:01.41   HostAsync - completed with HostResult = 0
13:51:01.41   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
13:51:01.41   Activating screen: OnlineGameSetup
13:51:01.41   MessageInternal::CreateChannel: Created channel 534d5347
13:51:01.41   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:01.41   MatchInternal::SetMatchType - new type 14 - updating server
13:51:01.41   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:127.0.0.1:6112; (ping=0ms) 100.00%, pending=0, dead=0
13:51:01.41   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
13:51:01.42   Transport - Largest received is now 527
13:51:01.43   SetVisible called while !IsConnected
13:51:01.43   GetMaxFrameTimeFromProfile: players=2 expected FPS=19.319939, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
13:51:01.43   Activating screen: RelicOnlineChat
13:51:01.43   Activating screen: RelicOnlineNewsScreen
13:51:01.43   Activating screen: RelicOnlineStatsScreen
13:51:01.43   Activating screen: Achievements
13:51:01.43   GAME -- Setting campaign state to 'dlc1'
13:51:01.43   GAME -- Closing state 'dlc1'
13:51:01.44   GAME -- Setting campaign state to 'dlc1'
13:51:01.44   GAME -- Closing state 'dlc1'
13:51:01.44   GAME -- Setting campaign state to 'dlc2'
13:51:01.44   GAME -- Closing state 'dlc2'
13:51:01.44   GAME -- Setting campaign state to 'dlc3'
13:51:01.44   GAME -- Closing state 'dlc3'
13:51:01.44   GAME -- Setting campaign state to 'dlc1'
13:51:01.44   GAME -- Closing state 'dlc1'
13:51:01.44   Transport - Largest received is now 1168
13:51:01.45   Activating screen: GameHistory
13:51:01.45   GAME -- Setting campaign state to 'dlc1'
13:51:01.46   Transport - Largest received is now 1196
13:51:01.53   GAME -- Closing state 'dlc1'
13:51:01.53   GAME -- Setting campaign state to 'dlc2'
13:51:01.53   GAME -- Closing state 'dlc2'
13:51:01.53   GAME -- Setting campaign state to 'dlc3'
13:51:01.53   GAME -- Closing state 'dlc3'
13:51:01.54   Activating screen: OnlineGameSetup
13:51:01.54   Activating screen: RelicOnlineTabs
13:51:01.54   AutomatchInternal::OnHostComplete - Completed Host with success=1
13:51:01.54   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
13:51:01.54   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
13:51:01.55   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:01.55   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:01.55   GetMaxFrameTimeFromProfile: players=2 expected FPS=19.319939, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
13:51:01.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:01.63   GAME -- Setting campaign state to 'dlc1'
13:51:01.63   GAME -- Closing state 'dlc1'
13:51:01.63   GAME -- Setting campaign state to 'dlc2'
13:51:01.63   GAME -- Closing state 'dlc2'
13:51:01.64   GAME -- Setting campaign state to 'dlc3'
13:51:01.64   GAME -- Closing state 'dlc3'
13:51:01.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:03.29   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:03.29   Net::Session::SetVisible - session is set to VISIBLE.
13:51:03.29   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
13:51:03.31   TGAIO -- TGA file 'Data:scenarios\mp\8p_berlin_1945_b041_map_base.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
13:51:03.35   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:03.39   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:05.34   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:05.34   Net::Session::SetVisible - session is set to VISIBLE.
13:51:05.34   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:05.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:05.43   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:08.34   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:08.34   Net::Session::SetVisible - session is set to VISIBLE.
13:51:08.34   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:08.45   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:08.49   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:09.87   Activating screen: RaceSelectionPopup
13:51:10.46   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:11.29   Activating screen: RaceSelectionPopup
13:51:11.84   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:11.84   Net::Session::SetVisible - session is set to VISIBLE.
13:51:11.84   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:11.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:11.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:12.47   Activating screen: DynamicPopupMenu
13:51:13.04   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:13.04   Net::Session::SetVisible - session is set to VISIBLE.
13:51:13.04   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:13.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:13.07   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:13.49   Activating screen: DynamicPopupMenu
13:51:14.11   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:14.11   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:14.11   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:14.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:14.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:14.71   Activating screen: RaceSelectionPopup
13:51:15.39   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:15.39   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:15.39   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:15.40   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:15.42   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:15.95   Activating screen: RaceSelectionPopup
13:51:16.47   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:16.47   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:16.47   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:16.49   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:16.53   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:17.13   Activating screen: DynamicPopupMenu
13:51:17.85   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:17.85   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:17.85   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:17.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:17.89   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:18.53   Activating screen: DynamicPopupMenu
13:51:19.24   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:19.24   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:19.24   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:19.25   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:19.28   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:19.65   Activating screen: DynamicPopupMenu
13:51:20.35   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:20.35   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:20.35   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:20.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:20.39   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:21.89   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:21.89   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:21.89   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:21.91   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:21.94   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:23.49   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:23.49   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:23.49   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:23.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:23.53   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:25.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.4, max unsent 0, version err 0, merge 0
13:51:26.66   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:26.66   Net::Session::SetVisible - session is set to INVISIBLE.
13:51:26.67   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
13:51:26.68   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:26.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:27.59   GameSetupForm - No win/loss reporting and only a single player, disconnecting
13:51:27.59   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
13:51:27.59   SetVisible called while !IsConnected
13:51:27.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:27.59   GameSetupForm - Starting game
13:51:27.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
13:51:27.59   PopulateGameInfo - random seed:[1309589487], guid:[{530ea9f8-142b-448c-955b-86aa69b30e1e}], sync level:[2]
13:51:27.60   Error loading [DATA:levelingCurve.lua]
13:51:27.60   Error loading [DATA:levelingCurve.lua]
13:51:27.60   Error loading [DATA:levelingCurve.lua]
13:51:27.60   Error loading [DATA:levelingCurve.lua]
13:51:27.60   Error loading [DATA:levelingCurve.lua]
13:51:27.61   Error loading [DATA:levelingCurve.lua]
13:51:27.61   MOD - Setting player (0) race to: allies_soviets
13:51:27.61   MOD - Setting player (0) race to: 2
13:51:27.61   MOD - Setting player (1) race to: allies_soviets
13:51:27.61   MOD - Setting player (1) race to: 2
13:51:27.61   MOD - Setting player (2) race to: allies_soviets
13:51:27.61   MOD - Setting player (2) race to: 2
13:51:27.61   MOD - Setting player (3) race to: axis
13:51:27.61   MOD - Setting player (3) race to: 3
13:51:27.61   MOD - Setting player (4) race to: axis
13:51:27.61   MOD - Setting player (4) race to: 3
13:51:27.61   MOD - Setting player (5) race to: axis
13:51:27.61   MOD - Setting player (5) race to: 3
13:51:27.61   Activating screen: MessageBoxPopup
13:51:27.61   Session is marking the local peer PeerID 1 for death
13:51:27.61   Session::GetEvent DestroyPeer success Peer 1 removed
13:51:27.61   Session::DestroyPeer - deallocating peer 1
13:51:27.61   Session - Requested Disconnect for connectionID 2
13:51:27.61   Deallocated route ID=3 for PeerID 1 at WINaddr:127.0.0.1:6112;
13:51:27.61   Session - Requested Disconnect for connectionID 3
13:51:27.61   Closed route 3<>3 for PeerID 1 at WINaddr:127.0.0.1:6112;
13:51:27.61   AdvertisementInternal::Process - EVENT_DESTROYPEER
13:51:27.61   Destroyed Matchinfo
13:51:27.61   Transport - Largest sent is now 8
13:51:27.62   APP -- Game Start
13:51:27.62   Sent message game CompanyOfHeroes allowtraffic
13:51:27.62   GAME -- Setting campaign state to 'dlc1'
13:51:27.62   GAME -- Closing state 'dlc1'
13:51:27.62   GAME -- Setting campaign state to 'dlc2'
13:51:27.62   GAME -- Closing state 'dlc2'
13:51:27.63   GAME -- Setting campaign state to 'dlc3'
13:51:27.63   GAME -- Closing state 'dlc3'
13:51:27.63   MessageInternal::DestroyChannel: Destroyed channel 534d5347
13:51:27.65   GAME -- Ending FE
13:51:27.65   UIFrontEnd - Unloading Front End
13:51:27.67   SOUND -- Shutting down ...
13:51:27.72   SOUND -- Shutdown completed!
13:51:27.74
13:51:27.74   GAME -- *** Beginning mission 6p_kiev (1 Humans, 5 Computers) ***
13:51:27.74
13:51:28.02   GAME -- Recording game
13:51:28.09   Activating screen: GameLoadScreen
13:51:28.09   ReportGameStartStats - no connection to server unable to report
13:51:28.09   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
13:51:28.09   PeerRemoveAll - flushing local session peer data
13:51:28.09   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
13:51:28.09   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
13:51:28.60   THREAD: Hyper-Threading Technology Processors are not detected.
13:51:28.69   SOUND -- Initializing ...
13:51:29.43   SOUND -- Initialization completed!
13:51:29.45   PHYSICS: detected processor(s) capable of handling 4 threads.
13:51:29.45   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\6p_kiev'
13:51:29.45   MOD -- Using Mod 'Eastern_Front'
13:51:29.49   Unable to load/parse precache file [DATA:scenarios\mp\6p_kiev_precache.lua]
13:51:29.61   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
13:51:29.62   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
13:51:33.05   GameObjLoader - upgrading load_count from 0 to 1093
13:51:35.63   GameObjLoader - upgrading load_count from 1093 to 1822
13:51:52.77   GameObjLoader - upgrading load_count from 27 to 4438
13:51:58.06   GameObjLoader 5078e4b8 - resetting counters
13:51:58.06   GameObjLoader 5078e4b8 - LOAD_DONE
13:51:58.06   GAME - SessionSetup
13:51:58.47   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
13:51:58.47   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 2048 x 2048
13:51:58.47   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
13:52:01.82   GAME - CreateGEWorld in 3760 ms
13:52:01.83   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
13:52:01.94   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
13:52:02.49   GAME - SessionSetup finished in 4422 ms
13:52:02.49   GAME - WaterReflectionManagerSetup
13:52:02.49   GAME - WaterReflectionManagerSetup finished in 0 ms
13:52:03.09   MessageInternal::CreateChannel: Created channel 474d4343
13:52:03.10   Regenerating ImpassMap data...
13:52:03.10       Impass Data was already valid, but regenerating...
13:52:03.42   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
13:52:03.42   Regenerating CanBuildMap data...
13:52:03.43   Generating CanShoot Map.
13:52:03.43   Pathfinder::Regenerate()...
13:52:03.53   Generating PathSectorMap...
13:52:04.19   Pathfinder::Regenerate() Done.
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x580c34b8
[Cope FactionFix] - Hook already installed
13:52:04.35   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
13:52:04.93   MOD -- Player  (unused player) (frame 0) (KillPlayer)
13:52:04.93   MOD -- Player  (unused player) (frame 0) (KillPlayer)
13:52:05.75   MessageInternal::CreateChannel: Created channel 4d4f444d
13:52:06.66   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
13:52:06.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
13:52:06.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
13:52:06.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
13:52:06.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
13:52:07.28   SPEECHMANAGER -- Loaded in 0.562657 seconds
13:52:09.32   GameObjLoader - upgrading load_count from 0 to 415
13:52:11.56   GameObjLoader 5078e618 - resetting counters
13:52:11.56   GameObjLoader 5078e618 - LOAD_DONE
13:52:14.38   PreloadResources took 2740ms.
13:52:15.05   GAME -- Loading completed (47 seconds)
13:52:15.05   SIM -- Setting SyncErrorChecking level to None
13:52:17.24   Activating screen: GameScreen
13:52:17.24   Activating screen: Decorators
13:52:17.24   Activating screen: Taskbar
13:52:17.24   Activating screen: SubtitleScreen
13:52:17.24   Activating screen: TextOverlayScreen
13:52:18.75   PerformanceRecorder::StartRecording for game size 6
13:52:18.75   GAME -- Starting mission...
13:52:20.47   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
13:52:20.47   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
13:52:20.47   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
13:52:20.47   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
13:52:20.47   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
13:52:25.19   Warning: non auto-match upgrade not found in AE, tuning
13:52:26.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
13:52:37.39   Activating screen: Command_Tree
13:52:38.14   Activating screen: Command_Branch
13:52:46.76   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
13:53:27.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
13:53:38.25   Warning: binding repeat_3(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
13:53:38.25   Warning: binding repeat_4(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12]
13:53:55.87   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
13:54:28.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
13:54:56.37   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
13:55:29.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
13:55:30.63   Activating screen: Command_Branch
13:56:30.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
13:57:31.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
13:57:34.74   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
13:57:34.74   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
13:57:34.74   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.
13:57:37.65   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
13:57:37.65   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
13:57:37.65   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.
13:57:50.74   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
13:57:50.74   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
13:57:50.74   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.
13:57:58.46   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
13:57:58.46   Muting spew of bind updater.  Fix art and re-test.
13:58:01.11   Activating screen: Command_Branch
13:58:32.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
13:59:33.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:00:19.02   Was already stealing a skeleton when told to steal another [heavymachinegun_target].
14:00:34.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:01:35.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:01:37.61   Activating screen: Command_Branch
14:02:03.21   Activating screen: pause_menu
14:02:03.27   GAME -- SimulationController::Pause 0
14:02:36.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:03:37.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
14:04:38.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:04:53.70   GAME -- SimulationController::Pause 1
14:04:57.30   Unabled to do upgrade, CANPRODUCE_NoResources
14:04:58.30   Unabled to do upgrade, CANPRODUCE_NoResources
14:04:59.30   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:00.32   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:01.31   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:02.81   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:04.40   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:05.41   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:06.39   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:07.52   Unabled to do upgrade, CANPRODUCE_NoResources
14:05:39.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:06:40.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:07:41.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
14:08:42.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:09:25.03   FXShader::SetVariable( "tex0", T ) uses unknown variable.
14:09:43.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:10:44.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
14:10:53.07   Unabled to do upgrade, CANPRODUCE_NoResources
14:10:53.32   Activating screen: Command_Branch
14:11:36.29   Unabled to do upgrade, CANPRODUCE_NoResources
14:11:45.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:12:07.23   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
14:12:46.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
14:13:47.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:14:48.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:15:49.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
14:16:04.77   Activating screen: Command_Branch
14:16:50.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:17:51.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:18:52.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
14:19:53.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
