-- Log file for all dbTracef messages --

20:52:18.83   NetworkManager::Create - creating network manager
20:52:18.83   Read 269 bytes from network datastore login_cache.bin
20:52:18.83   Read 52 bytes from network datastore global_cache.bin
20:52:18.83   Read 28 bytes from network datastore ping_cache.bin
20:52:18.83   QuazalInitializer - static initializing Quazal library
20:52:18.83   PingCache - populating cache with 0 pings
20:52:18.92   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
20:52:18.98   WinTransport - CreateSocket exclusive broadcast socket was available.
20:52:18.98   WinTransport - CreateSocket listening for broadcasts on default port
20:52:18.98   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
20:52:18.98   WinTransport - Host IP Address #0: 5.3.208.164
20:52:18.98   WinTransport - WARNING, MultipleNetwork adapters may cause problems
20:52:18.98   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
20:52:18.98   WinTransport - Interface #1: ip:192.168.1.101, broadcast:192.168.1.101, flags=IFF_BROADCAST IFF_MULTICAST
20:52:18.98   WinTransport - Interface #2: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
20:52:18.98   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
20:52:18.98   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
20:52:18.98   SessionManager - Peer Header Size = 16 bytes
20:52:18.98   SessionManager - Game Data overhead = 7 bytes
20:52:18.98   SessionManager - Proxy overhead = 7 bytes
20:52:18.98   MessageInternal::CreateChannel: Created channel 47535450
20:52:18.98   Session::Initialize - info, initializing session object, using threads.
20:52:18.98   SessionManager::RegisterSession - Registering new session 07002e40
20:52:18.98   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
20:52:18.98   AutomatchInternal: Instantiating
20:52:18.98   PartyInternal: Instantiating
20:52:18.98   MessageInternal::CreateChannel: Created channel 50525459
20:52:18.98   Net::ThreadFunction - Entering network thread function...
20:52:18.98   MessageInternal::CreateChannel: Created channel 51434b4d
20:52:18.98   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
20:52:18.98   MessageInternal::CreateChannel: Created channel 534d5347
20:52:18.98   MessageInternal::CreateChannel: Created channel 474d4343
20:52:18.98   MessageInternal::CreateChannel: Created channel 474f424a
20:52:18.98   MessageInternal::CreateChannel: Created channel 4d4f444d
20:52:18.98   MessageInternal::CreateChannel: Created channel 53594e43
20:52:18.98   MessageInternal::DestroyChannel: Destroyed channel 534d5347
20:52:18.98   MessageInternal::DestroyChannel: Destroyed channel 474d4343
20:52:18.98   MessageInternal::DestroyChannel: Destroyed channel 474f424a
20:52:18.98   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
20:52:18.98   MessageInternal::DestroyChannel: Destroyed channel 53594e43
20:52:19.00   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
20:52:19.02   Transport - Largest received is now 19
20:52:19.02   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
20:52:19.03   Transport - Largest sent is now 19
20:52:21.93   DLLDriverLinker -- Adding driver 'spDx10.dll'.
20:52:21.93   DLLDriverLinker -- Adding driver 'spDx9.dll'.
20:52:21.93   DLLDriverLinker -- 2 DLL drivers found.
20:52:22.00   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
20:52:23.70   DLLDriverLinker -- 2 DLL drivers found.
20:52:23.82   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
20:52:23.82   GAME -- Resolution set to 1024x768 (fullscreen).
20:52:23.87   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
20:52:23.87   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
20:52:23.87   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
20:52:23.87   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
20:52:24.41   SPDx9 -- 1774MB available Texture Memory
20:52:24.41   ShaderDatabase: using shader profile [ps30]
20:52:24.91   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
20:52:25.13   GameObjLoader 07930ec0 - resetting counters
20:52:25.13   GameObjLoader 07930ec0 - Created loader
20:52:25.13   GameObjLoader 07931020 - resetting counters
20:52:25.13   GameObjLoader 07931020 - Created loader
20:52:34.91   GAME -- Beginning FE
20:52:34.91   Sent message game CompanyOfHeroes started 4584 602 allowtraffic
20:52:34.91   RemoteDLManager - Connection Restored.
20:52:34.91   UIFrontEnd - Loading Front End
20:52:34.91   THREAD: Hyper-Threading Technology Processors are not detected.
20:52:35.02   SOUND -- Initializing ...
20:52:35.08   INNIMapDCA Key not found: sp_speechducker::time
20:52:35.59   SOUND -- Initialization completed!
20:52:35.59   UIFrontEnd - Initializing Forms
20:52:37.31   CampaignFilter::BindFilterSpecificWidgets()
20:52:37.40   Activating screen: AppLoadingForm
20:52:37.40   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
20:52:37.40   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
20:52:38.04   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
20:52:38.04   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
20:52:38.04   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
20:52:38.04   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
20:52:38.04   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
20:52:38.05   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
20:52:38.43   GAME -- Using player profile NGOCQUANG-PC
20:52:41.53   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
20:52:42.42   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
20:52:43.44   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
20:52:43.44   RendezvousManager: CreateSession - starting profile=Guest login
20:52:43.49   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
20:52:43.49   RendezvousManager - unable to connect to the server as guest
20:52:43.51   OnConnect: connect failure
20:52:43.51   RendezvousManager::Shutdown - deleting instance
20:52:43.51   RendezvousManager - terminating all server calls in progress
20:52:43.51   CallManager - terminating all server calls in progress (1 in progress)
20:52:43.51   RendezvousManager - destroying chat handler
20:52:43.51   ~RendezvousManager - m_state = 7, no need for server disconnect
20:52:43.53   OnConnect: this wasnt a reconnect, no need for autologin
20:52:43.54   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
20:52:43.55   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
20:52:43.55   Activating screen: FEMovie
20:52:43.55   Activating screen: OnlineWidget
20:52:43.55   Activating screen: RelicOnlineLogin
20:52:43.59   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
20:52:43.59   You have a valid version of the game.
20:52:43.61   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
20:52:43.61   installed_products = ( DLC1 DLC2 DLC3 )
20:52:43.61   OnLogin: no previous login, auto selecting profile not required
20:52:43.61   Activating screen: MessageBoxPopup
20:52:43.61   Activating screen: MessageBoxPopup
20:52:43.61   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
20:52:47.40   Beginning media verification...
20:52:47.40   Validator type : validators\udro\udro.dll
20:52:47.40   Activating screen: MessageBoxPopup
20:52:47.44   Activating screen: FE_mm_01
20:52:47.44   GAME -- Setting campaign state to 'dlc1'
20:52:47.44   GAME -- Closing state 'dlc1'
20:52:47.44   GAME -- Setting campaign state to 'dlc2'
20:52:47.44   GAME -- Closing state 'dlc2'
20:52:47.44   GAME -- Setting campaign state to 'dlc3'
20:52:47.44   GAME -- Closing state 'dlc3'
20:52:48.40   Activating screen: MessageBoxPopup
20:52:48.40   Created Matchinfo
20:52:48.40   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
20:52:48.40   starting LAN hosting
20:52:48.44   OnJoinAdvertisementSuccess - joined online match, server leave notification required
20:52:48.44   starting local hosting
20:52:48.44   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
20:52:48.44   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
20:52:48.44   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
20:52:48.44   Session::Host sid = F7103B604D7C721B, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
20:52:48.44   ValidateCustomData: called with 217 bytes of custom data
20:52:48.44   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
20:52:48.44   AdvertisementInternal::Process - EVENT_NEWPEER
20:52:48.44   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
20:52:48.45   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
20:52:48.45   hosting - Session is connected
20:52:48.45   Net::Session::SetVisible - session is set to VISIBLE.
20:52:48.47   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
20:52:48.47   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
20:52:48.47   hosting completed successfully
20:52:48.47   HostAsync - completed with HostResult = 0
20:52:48.47   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
20:52:48.47   Activating screen: OnlineGameSetup
20:52:48.47   MessageInternal::CreateChannel: Created channel 534d5347
20:52:48.47   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:52:48.47   MatchInternal::SetMatchType - new type 14 - updating server
20:52:48.48   Transport - Largest received is now 479
20:52:48.48   SetVisible called while !IsConnected
20:52:48.48   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:52:48.49   Activating screen: RelicOnlineChat
20:52:48.49   Activating screen: RelicOnlineNewsScreen
20:52:48.49   Activating screen: RelicOnlineStatsScreen
20:52:48.49   Activating screen: Achievements
20:52:48.49   GAME -- Setting campaign state to 'dlc1'
20:52:48.49   GAME -- Closing state 'dlc1'
20:52:48.49   GAME -- Setting campaign state to 'dlc1'
20:52:48.49   GAME -- Closing state 'dlc1'
20:52:48.50   Transport - Largest received is now 574
20:52:48.50   GAME -- Setting campaign state to 'dlc2'
20:52:48.50   GAME -- Closing state 'dlc2'
20:52:48.50   GAME -- Setting campaign state to 'dlc3'
20:52:48.50   GAME -- Closing state 'dlc3'
20:52:48.50   GAME -- Setting campaign state to 'dlc1'
20:52:48.50   GAME -- Closing state 'dlc1'
20:52:48.51   Activating screen: GameHistory
20:52:48.51   GAME -- Setting campaign state to 'dlc1'
20:52:48.51   GAME -- Closing state 'dlc1'
20:52:48.51   GAME -- Setting campaign state to 'dlc2'
20:52:48.51   GAME -- Closing state 'dlc2'
20:52:48.52   Transport - Largest received is now 1189
20:52:48.52   GAME -- Setting campaign state to 'dlc3'
20:52:48.52   GAME -- Closing state 'dlc3'
20:52:48.52   Activating screen: OnlineGameSetup
20:52:48.52   Activating screen: RelicOnlineTabs
20:52:48.52   AutomatchInternal::OnHostComplete - Completed Host with success=1
20:52:48.52   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
20:52:48.52   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
20:52:48.53   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:52:48.53   Net::Session::SetVisible - session is set to VISIBLE.
20:52:48.53   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:52:48.58   TGAIO -- TGA file 'Data:scenarios\mp\eichsfeld confluence_map_base.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
20:52:48.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:52:48.63   GAME -- Setting campaign state to 'dlc1'
20:52:48.64   GAME -- Closing state 'dlc1'
20:52:48.64   GAME -- Setting campaign state to 'dlc2'
20:52:48.64   GAME -- Closing state 'dlc2'
20:52:48.64   GAME -- Setting campaign state to 'dlc3'
20:52:48.64   GAME -- Closing state 'dlc3'
20:52:48.69   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:52:50.75   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:52:50.75   Net::Session::SetVisible - session is set to INVISIBLE.
20:52:50.75   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:52:50.76   Transport - Largest received is now 1196
20:52:50.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:52:50.83   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:52:55.81   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:52:55.81   Net::Session::SetVisible - session is set to INVISIBLE.
20:52:55.81   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:52:55.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:52:55.96   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:13.19   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:53:13.19   Net::Session::SetVisible - session is set to INVISIBLE.
20:53:13.19   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:53:13.28   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:13.31   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:15.11   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:53:15.11   Net::Session::SetVisible - session is set to VISIBLE.
20:53:15.12   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:53:15.16   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:15.19   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:19.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.7/0.1, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
20:53:23.83   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:53:23.83   Net::Session::SetVisible - session is set to VISIBLE.
20:53:23.83   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
20:53:23.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:23.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:30.15   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:53:30.15   Net::Session::SetVisible - session is set to VISIBLE.
20:53:30.15   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:53:30.16   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:30.20   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:35.45   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:53:35.45   Net::Session::SetVisible - session is set to VISIBLE.
20:53:35.46   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:53:35.49   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:35.55   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:40.80   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:53:40.80   Net::Session::SetVisible - session is set to VISIBLE.
20:53:40.80   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
20:53:40.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:40.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:46.46   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:53:46.46   Net::Session::SetVisible - session is set to VISIBLE.
20:53:46.46   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:53:46.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:46.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:53:49.00   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
20:53:49.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=16/17, 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=18/18, frag=0/0, Errors=0/0
20:53:53.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:09.58   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:12.62   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:12.62   Net::Session::SetVisible - session is set to VISIBLE.
20:54:12.62   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:12.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:12.69   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:13.72   Activating screen: RaceSelectionPopup
20:54:14.47   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:14.47   Net::Session::SetVisible - session is set to VISIBLE.
20:54:14.48   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:14.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:14.54   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:14.98   Activating screen: DynamicPopupMenu
20:54:15.59   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:15.59   Net::Session::SetVisible - session is set to INVISIBLE.
20:54:15.59   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:15.61   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:15.64   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:16.04   Activating screen: RaceSelectionPopup
20:54:16.82   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:16.82   Net::Session::SetVisible - session is set to INVISIBLE.
20:54:16.82   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:16.83   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:16.86   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:17.50   Activating screen: DynamicPopupMenu
20:54:18.36   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:18.36   Net::Session::SetVisible - session is set to INVISIBLE.
20:54:18.36   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:18.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:18.41   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:18.99   Activating screen: DynamicPopupMenu
20:54:19.86   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:19.86   Net::Session::SetVisible - session is set to INVISIBLE.
20:54:19.86   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:19.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:19.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:20.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
20:54:20.43   Activating screen: DynamicPopupMenu
20:54:24.61   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:24.61   Net::Session::SetVisible - session is set to INVISIBLE.
20:54:24.61   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:24.63   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:24.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:26.07   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:26.07   Net::Session::SetVisible - session is set to INVISIBLE.
20:54:26.07   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:26.08   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:26.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:27.50   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:27.50   Net::Session::SetVisible - session is set to INVISIBLE.
20:54:27.51   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
20:54:27.52   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:27.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:28.78   GameSetupForm - No win/loss reporting and only a single player, disconnecting
20:54:28.78   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
20:54:28.78   SetVisible called while !IsConnected
20:54:28.78   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:28.79   GameSetupForm - Starting game
20:54:28.79   GameInfo::ResetInfo - SyncLevel set to 0 on reset
20:54:28.79   PopulateGameInfo - random seed:[1308578068], guid:[{a1cbdc08-a33d-47a7-a24e-b3ec5dd53b2e}], sync level:[2]
20:54:28.79   Error loading [DATA:levelingCurve.lua]
20:54:28.80   Error loading [DATA:levelingCurve.lua]
20:54:28.80   Error loading [DATA:levelingCurve.lua]
20:54:28.80   Error loading [DATA:levelingCurve.lua]
20:54:28.80   MOD - Setting player (0) race to: allies_soviets
20:54:28.80   MOD - Setting player (0) race to: 2
20:54:28.80   MOD - Setting player (1) race to: allies_soviets
20:54:28.80   MOD - Setting player (1) race to: 2
20:54:28.80   MOD - Setting player (2) race to: axis
20:54:28.80   MOD - Setting player (2) race to: 3
20:54:28.80   MOD - Setting player (3) race to: axis
20:54:28.80   MOD - Setting player (3) race to: 3
20:54:28.80   Activating screen: MessageBoxPopup
20:54:28.80   Session is marking the local peer PeerID 1 for death
20:54:28.80   Session::GetEvent DestroyPeer success Peer 1 removed
20:54:28.80   Session::DestroyPeer - deallocating peer 1
20:54:28.80   Session - Requested Disconnect for connectionID 2
20:54:28.80   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
20:54:28.80   Session - Requested Disconnect for connectionID 3
20:54:28.80   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
20:54:28.80   AdvertisementInternal::Process - EVENT_DESTROYPEER
20:54:28.80   Destroyed Matchinfo
20:54:28.81   APP -- Game Start
20:54:28.81   Sent message game CompanyOfHeroes allowtraffic
20:54:28.81   GAME -- Setting campaign state to 'dlc1'
20:54:28.81   GAME -- Closing state 'dlc1'
20:54:28.82   GAME -- Setting campaign state to 'dlc2'
20:54:28.82   GAME -- Closing state 'dlc2'
20:54:28.82   GAME -- Setting campaign state to 'dlc3'
20:54:28.82   GAME -- Closing state 'dlc3'
20:54:28.83   MessageInternal::DestroyChannel: Destroyed channel 534d5347
20:54:28.84   GAME -- Ending FE
20:54:28.84   UIFrontEnd - Unloading Front End
20:54:28.85   SOUND -- Shutting down ...
20:54:28.94   SOUND -- Shutdown completed!
20:54:28.95
20:54:28.95   GAME -- *** Beginning mission NORTH AFRICA 1942 (1 Humans, 3 Computers) ***
20:54:28.95
20:54:28.95   GAME -- Recording game
20:54:29.04   Activating screen: GameLoadScreen
20:54:29.04   ReportGameStartStats - no connection to server unable to report
20:54:29.04   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
20:54:29.04   PeerRemoveAll - flushing local session peer data
20:54:29.04   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
20:54:29.04   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
20:54:29.47   THREAD: Hyper-Threading Technology Processors are not detected.
20:54:29.56   SOUND -- Initializing ...
20:54:30.29   SOUND -- Initialization completed!
20:54:30.33   PHYSICS: detected processor(s) capable of handling 4 threads.
20:54:30.34   MOD -- Locating MOD for scenario 'DATA:Scenarios\MP\NORTH AFRICA 1942'
20:54:30.34   MOD -- Using Mod 'Eastern_Front'
20:54:30.36   Unable to load/parse precache file [DATA:Scenarios\MP\NORTH AFRICA 1942_precache.lua]
20:54:30.46   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
20:54:30.47   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
20:54:34.01   GameObjLoader - upgrading load_count from 0 to 1051
20:54:37.79   GameObjLoader - upgrading load_count from 1051 to 1710
20:54:37.87   PHYSICS -- Created node factory 'HVOK'
20:54:37.87   PHYSICS -- Created node factory 'DMMY'
20:55:05.89   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
20:55:21.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
20:55:34.33   GameObjLoader - upgrading load_count from 41 to 4048
20:55:45.37   GameObjLoader 07930ec0 - resetting counters
20:55:45.37   GameObjLoader 07930ec0 - LOAD_DONE
20:55:45.37   GAME - SessionSetup
20:55:45.37   GAME -- Can't initialize scenario pack more than once.
20:55:45.58   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
20:55:45.79   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
20:55:45.79   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
20:55:45.79   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
20:55:48.56   GAME - CreateGEWorld in 3190 ms
20:55:48.63   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
20:55:48.80   GAME - SessionSetup finished in 3430 ms
20:55:48.81   GAME - WaterReflectionManagerSetup
20:55:48.81   GAME - WaterReflectionManagerSetup finished in 0 ms
20:55:49.01   MessageInternal::CreateChannel: Created channel 474d4343
20:55:49.03   Regenerating ImpassMap data...
20:55:49.03       Impass Data was already valid, but regenerating...
20:55:49.22   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
20:55:49.22   Regenerating CanBuildMap data...
20:55:49.22   Generating CanShoot Map.
20:55:49.22   Pathfinder::Regenerate()...
20:55:49.27   Generating PathSectorMap...
20:55:49.63   Pathfinder::Regenerate() Done.
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x06601020
[Cope FactionFix] - patched @0x6a275491
[Cope FactionFix] - hooked @0x6a275492
[Cope FactionFix] - patched @0x6a274a07
[Cope FactionFix] - hooked @0x6a274a07
[Cope FactionFix] - Hook installed
20:55:49.98   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilateNoPop.scar] succeeded.
20:55:50.50   MOD -- Player  (unused player) (frame 0) (KillPlayer)
20:55:50.50   MOD -- Player  (unused player) (frame 0) (KillPlayer)
20:55:50.50   MOD -- Player  (unused player) (frame 0) (KillPlayer)
20:55:50.50   MOD -- Player  (unused player) (frame 0) (KillPlayer)
20:55:51.39   MessageInternal::CreateChannel: Created channel 4d4f444d
20:55:52.21   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
20:55:52.21   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
20:55:52.21   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
20:55:52.21   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
20:55:52.21   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
20:55:52.80   SPEECHMANAGER -- Loaded in 0.547101 seconds
20:55:54.82   GameObjLoader - upgrading load_count from 0 to 462
20:55:57.08   GameObjLoader 07931020 - resetting counters
20:55:57.08   GameObjLoader 07931020 - LOAD_DONE
20:55:59.20   PreloadResources took 2060ms.
20:55:59.34   GAME -- Loading completed (90 seconds)
20:55:59.34   SIM -- Setting SyncErrorChecking level to None
20:56:21.27   Activating screen: GameScreen
20:56:21.27   Activating screen: Decorators
20:56:21.27   Activating screen: Taskbar
20:56:21.27   Activating screen: SubtitleScreen
20:56:21.27   Activating screen: TextOverlayScreen
20:56:21.40   PerformanceRecorder::StartRecording for game size 4
20:56:21.40   GAME -- Starting mission...
20:56:22.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.8/0.1, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
20:56:22.01   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
20:56:22.01   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
20:56:22.01   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
20:56:26.72   Warning: non auto-match upgrade not found in AE, tuning
20:56:30.09   Activating screen: Command_Tree
20:56:32.03   Activating screen: Command_Branch
20:56:40.36   Activating screen: Command_Branch
20:56:47.16   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
20:57:23.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
20:57:29.14   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
20:57:42.43   Warning: binding repeat_0(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12]
20:57:42.46   Warning: binding repeat_2(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
20:58:24.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
20:59:25.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
20:59:45.92   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
20:59:53.78   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
21:00:26.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:00:50.80   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
21:00:50.93   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
21:00:53.19   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
21:01:27.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:01:37.19   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:01:37.19   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:01:37.19   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.
21:01:38.01   Activating screen: Command_Branch
21:01:47.55   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:01:47.55   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:01:47.55   Muting spew of bind updater.  Fix art and re-test.
21:02:28.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:03:29.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:04:30.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:05:31.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:06:32.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
21:07:30.76   FXShader::SetVariable( "tex0", T ) uses unknown variable.
21:07:33.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:07:44.20   Activating screen: Command_Branch
21:08:34.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:09:35.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:09:46.09   Activating screen: Command_Branch
21:10:36.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:11:37.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:12:38.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:13:39.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:14:40.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:15:41.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:16:42.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:16:52.80   Activating screen: Command_Branch
21:17:43.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:18:44.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
21:19:45.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:20:08.50   Unabled to do upgrade, CANPRODUCE_NoResources
21:20:09.49   Unabled to do upgrade, CANPRODUCE_NoResources
21:20:10.50   Unabled to do upgrade, CANPRODUCE_NoResources
21:20:11.49   Unabled to do upgrade, CANPRODUCE_NoResources
21:20:18.25   Unabled to do upgrade, CANPRODUCE_NoResources
21:20:25.25   Unabled to do upgrade, CANPRODUCE_NoResources
21:20:46.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:21:39.69   Activating screen: Command_Branch
21:21:47.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:22:48.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:23:49.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:24:50.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:25:48.08   Activating screen: Command_Branch
