-- Log file for all dbTracef messages --

12:50:04.08   NetworkManager::Create - creating network manager
12:50:04.08   Read 269 bytes from network datastore login_cache.bin
12:50:04.09   Read 52 bytes from network datastore global_cache.bin
12:50:04.09   Read 28 bytes from network datastore ping_cache.bin
12:50:04.09   QuazalInitializer - static initializing Quazal library
12:50:04.09   PingCache - populating cache with 0 pings
12:50:04.13   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
12:50:04.18   WinTransport - CreateSocket exclusive broadcast socket was available.
12:50:04.18   WinTransport - CreateSocket listening for broadcasts on default port
12:50:04.19   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
12:50:04.19   WinTransport - Host IP Address #0: 5.3.208.164
12:50:04.19   WinTransport - WARNING, MultipleNetwork adapters may cause problems
12:50:04.19   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
12:50:04.19   WinTransport - Interface #1: ip:192.168.1.100, broadcast:192.168.1.100, flags=IFF_BROADCAST IFF_MULTICAST
12:50:04.19   WinTransport - Interface #2: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
12:50:04.19   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
12:50:04.19   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
12:50:04.19   SessionManager - Peer Header Size = 16 bytes
12:50:04.19   SessionManager - Game Data overhead = 7 bytes
12:50:04.19   SessionManager - Proxy overhead = 7 bytes
12:50:04.19   MessageInternal::CreateChannel: Created channel 47535450
12:50:04.19   Session::Initialize - info, initializing session object, using threads.
12:50:04.19   SessionManager::RegisterSession - Registering new session 06742e40
12:50:04.19   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
12:50:04.19   AutomatchInternal: Instantiating
12:50:04.19   PartyInternal: Instantiating
12:50:04.19   MessageInternal::CreateChannel: Created channel 50525459
12:50:04.19   MessageInternal::CreateChannel: Created channel 51434b4d
12:50:04.19   Net::ThreadFunction - Entering network thread function...
12:50:04.19   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
12:50:04.19   MessageInternal::CreateChannel: Created channel 534d5347
12:50:04.19   MessageInternal::CreateChannel: Created channel 474d4343
12:50:04.19   MessageInternal::CreateChannel: Created channel 474f424a
12:50:04.19   MessageInternal::CreateChannel: Created channel 4d4f444d
12:50:04.19   MessageInternal::CreateChannel: Created channel 53594e43
12:50:04.19   MessageInternal::DestroyChannel: Destroyed channel 534d5347
12:50:04.19   MessageInternal::DestroyChannel: Destroyed channel 474d4343
12:50:04.19   MessageInternal::DestroyChannel: Destroyed channel 474f424a
12:50:04.19   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
12:50:04.19   MessageInternal::DestroyChannel: Destroyed channel 53594e43
12:50:04.19   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
12:50:04.21   Transport - Largest received is now 19
12:50:04.21   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
12:50:04.22   Transport - Largest sent is now 19
12:50:06.98   DLLDriverLinker -- Adding driver 'spDx10.dll'.
12:50:06.99   DLLDriverLinker -- Adding driver 'spDx9.dll'.
12:50:06.99   DLLDriverLinker -- 2 DLL drivers found.
12:50:07.05   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
12:50:08.95   DLLDriverLinker -- 2 DLL drivers found.
12:50:09.06   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
12:50:09.06   GAME -- Resolution set to 1024x768 (fullscreen).
12:50:09.09   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
12:50:09.09   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
12:50:09.09   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
12:50:09.09   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
12:50:09.63   SPDx9 -- 1774MB available Texture Memory
12:50:09.63   ShaderDatabase: using shader profile [ps30]
12:50:10.12   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
12:50:10.35   GameObjLoader 0e167e40 - resetting counters
12:50:10.35   GameObjLoader 0e167e40 - Created loader
12:50:10.35   GameObjLoader 0e167fa0 - resetting counters
12:50:10.35   GameObjLoader 0e167fa0 - Created loader
12:50:19.83   GAME -- Beginning FE
12:50:19.83   Sent message game CompanyOfHeroes started 4492 602 allowtraffic
12:50:19.83   RemoteDLManager - Connection Restored.
12:50:19.83   UIFrontEnd - Loading Front End
12:50:19.83   THREAD: Hyper-Threading Technology Processors are not detected.
12:50:19.94   SOUND -- Initializing ...
12:50:20.00   INNIMapDCA Key not found: sp_speechducker::time
12:50:20.50   SOUND -- Initialization completed!
12:50:20.50   UIFrontEnd - Initializing Forms
12:50:22.18   CampaignFilter::BindFilterSpecificWidgets()
12:50:22.27   Activating screen: AppLoadingForm
12:50:22.27   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
12:50:22.27   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
12:50:22.88   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
12:50:22.89   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
12:50:22.89   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
12:50:22.89   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
12:50:22.89   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
12:50:22.89   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
12:50:23.26   GAME -- Using player profile NGOCQUANG-PC
12:50:26.33   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
12:50:27.21   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
12:50:28.20   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
12:50:28.20   RendezvousManager: CreateSession - starting profile=Guest login
12:50:28.25   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
12:50:28.25   RendezvousManager - unable to connect to the server as guest
12:50:28.26   OnConnect: connect failure
12:50:28.26   RendezvousManager::Shutdown - deleting instance
12:50:28.26   RendezvousManager - terminating all server calls in progress
12:50:28.26   CallManager - terminating all server calls in progress (1 in progress)
12:50:28.26   RendezvousManager - destroying chat handler
12:50:28.26   ~RendezvousManager - m_state = 7, no need for server disconnect
12:50:28.28   OnConnect: this wasnt a reconnect, no need for autologin
12:50:28.30   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
12:50:28.30   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
12:50:28.30   Activating screen: FEMovie
12:50:28.30   Activating screen: OnlineWidget
12:50:28.30   Activating screen: RelicOnlineLogin
12:50:28.35   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
12:50:28.35   You have a valid version of the game.
12:50:28.37   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
12:50:28.37   installed_products = ( DLC1 DLC2 DLC3 )
12:50:28.37   OnLogin: no previous login, auto selecting profile not required
12:50:28.37   Activating screen: MessageBoxPopup
12:50:28.37   Activating screen: MessageBoxPopup
12:50:28.37   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
12:50:55.49   Beginning media verification...
12:50:55.49   Validator type : validators\udro\udro.dll
12:50:55.51   Activating screen: MessageBoxPopup
12:50:57.79   Activating screen: FE_mm_01
12:50:57.80   GAME -- Setting campaign state to 'dlc1'
12:50:57.80   GAME -- Closing state 'dlc1'
12:50:57.80   GAME -- Setting campaign state to 'dlc2'
12:50:57.80   GAME -- Closing state 'dlc2'
12:50:57.80   GAME -- Setting campaign state to 'dlc3'
12:50:57.80   GAME -- Closing state 'dlc3'
12:50:59.50   Activating screen: MessageBoxPopup
12:50:59.50   Created Matchinfo
12:50:59.50   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
12:50:59.50   starting LAN hosting
12:50:59.53   OnJoinAdvertisementSuccess - joined online match, server leave notification required
12:50:59.53   starting local hosting
12:50:59.53   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
12:50:59.53   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
12:50:59.53   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
12:50:59.53   Session::Host sid = 99073558C9CE9540, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
12:50:59.53   ValidateCustomData: called with 217 bytes of custom data
12:50:59.53   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
12:50:59.53   AdvertisementInternal::Process - EVENT_NEWPEER
12:50:59.53   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
12:50:59.55   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
12:50:59.55   hosting - Session is connected
12:50:59.55   Net::Session::SetVisible - session is set to VISIBLE.
12:50:59.55   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
12:50:59.55   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
12:50:59.56   hosting completed successfully
12:50:59.56   HostAsync - completed with HostResult = 0
12:50:59.56   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
12:50:59.56   Activating screen: OnlineGameSetup
12:50:59.56   MessageInternal::CreateChannel: Created channel 534d5347
12:50:59.56   Transport - Largest received is now 481
12:50:59.56   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:50:59.56   MatchInternal::SetMatchType - new type 14 - updating server
12:50:59.57   SetVisible called while !IsConnected
12:50:59.58   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
12:50:59.58   Activating screen: RelicOnlineChat
12:50:59.58   Activating screen: RelicOnlineNewsScreen
12:50:59.58   Activating screen: RelicOnlineStatsScreen
12:50:59.58   Activating screen: Achievements
12:50:59.58   GAME -- Setting campaign state to 'dlc1'
12:50:59.58   GAME -- Closing state 'dlc1'
12:50:59.58   Transport - Largest received is now 537
12:50:59.59   GAME -- Setting campaign state to 'dlc1'
12:50:59.59   GAME -- Closing state 'dlc1'
12:50:59.59   GAME -- Setting campaign state to 'dlc2'
12:50:59.59   GAME -- Closing state 'dlc2'
12:50:59.59   GAME -- Setting campaign state to 'dlc3'
12:50:59.59   GAME -- Closing state 'dlc3'
12:50:59.59   GAME -- Setting campaign state to 'dlc1'
12:50:59.59   GAME -- Closing state 'dlc1'
12:50:59.60   Activating screen: GameHistory
12:50:59.60   GAME -- Setting campaign state to 'dlc1'
12:50:59.60   GAME -- Closing state 'dlc1'
12:50:59.60   GAME -- Setting campaign state to 'dlc2'
12:50:59.60   GAME -- Closing state 'dlc2'
12:50:59.60   Transport - Largest received is now 1198
12:50:59.60   GAME -- Setting campaign state to 'dlc3'
12:50:59.60   GAME -- Closing state 'dlc3'
12:50:59.61   Activating screen: OnlineGameSetup
12:50:59.61   Activating screen: RelicOnlineTabs
12:50:59.61   AutomatchInternal::OnHostComplete - Completed Host with success=1
12:50:59.61   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
12:50:59.61   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
12:50:59.61   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:50:59.61   Net::Session::SetVisible - session is set to VISIBLE.
12:50:59.62   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
12:50:59.69   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:50:59.71   GAME -- Setting campaign state to 'dlc1'
12:50:59.71   GAME -- Closing state 'dlc1'
12:50:59.71   GAME -- Setting campaign state to 'dlc2'
12:50:59.71   GAME -- Closing state 'dlc2'
12:50:59.71   GAME -- Setting campaign state to 'dlc3'
12:50:59.71   GAME -- Closing state 'dlc3'
12:50:59.75   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:05.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.7/0.1, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
12:51:06.06   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:06.06   Net::Session::SetVisible - session is set to VISIBLE.
12:51:06.06   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
12:51:06.12   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:06.16   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:08.73   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:08.73   Net::Session::SetVisible - session is set to VISIBLE.
12:51:08.73   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:08.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:08.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:11.62   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:11.62   Net::Session::SetVisible - session is set to VISIBLE.
12:51:11.62   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:11.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:11.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:13.93   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:13.93   Net::Session::SetVisible - session is set to VISIBLE.
12:51:13.93   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:14.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:14.10   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:15.76   Activating screen: RaceSelectionPopup
12:51:16.74   Activating screen: DynamicPopupMenu
12:51:18.90   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
12:51:18.90   MatchInternal::SetMatchType - new type 0 - updating server
12:51:18.90   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
12:51:18.90   Net::Session::SetVisible - session is set to VISIBLE.
12:51:18.90   Net::Session::SetVisible - session is set to VISIBLE.
12:51:18.90   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:18.91   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:18.93   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
12:51:18.93   Net::Session::SetVisible - session is set to VISIBLE.
12:51:18.93   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:18.95   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:18.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:19.43   Activating screen: DynamicPopupMenu
12:51:20.34   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
12:51:20.34   Net::Session::SetVisible - session is set to VISIBLE.
12:51:20.34   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:20.34   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:20.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:21.33   Activating screen: DynamicPopupMenu
12:51:22.08   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
12:51:22.08   Net::Session::SetVisible - session is set to VISIBLE.
12:51:22.08   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:22.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:22.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:23.31   Activating screen: DynamicPopupMenu
12:51:24.03   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
12:51:24.03   Net::Session::SetVisible - session is set to VISIBLE.
12:51:24.03   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:24.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:24.08   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:24.56   Activating screen: DynamicPopupMenu
12:51:25.36   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
12:51:25.36   Net::Session::SetVisible - session is set to VISIBLE.
12:51:25.36   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:25.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:25.41   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:26.14   Activating screen: DynamicPopupMenu
12:51:26.90   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:26.90   MatchInternal::SetMatchType - new type 14 - updating server
12:51:26.90   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:26.90   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:26.90   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:26.90   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:26.91   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:26.93   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:26.93   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:26.93   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:26.95   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:26.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:27.81   Activating screen: RaceSelectionPopup
12:51:28.55   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:28.55   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:28.55   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:28.55   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:28.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:29.24   Activating screen: RaceSelectionPopup
12:51:29.92   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:29.92   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:29.92   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:29.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:29.96   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:30.37   Activating screen: RaceSelectionPopup
12:51:31.05   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:31.05   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:31.05   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:31.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:31.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:32.62   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:32.62   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:32.62   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:32.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:32.65   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:34.05   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:34.06   Net::Session::SetVisible - session is set to INVISIBLE.
12:51:34.06   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
12:51:34.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:34.10   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:34.87   GameSetupForm - No win/loss reporting and only a single player, disconnecting
12:51:34.87   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
12:51:34.87   SetVisible called while !IsConnected
12:51:34.87   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:34.88   GameSetupForm - Starting game
12:51:34.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
12:51:34.88   PopulateGameInfo - random seed:[1308549094], guid:[{3bcc80d8-4435-4f72-bfb0-b853d255adf7}], sync level:[2]
12:51:34.88   Error loading [DATA:levelingCurve.lua]
12:51:34.88   Error loading [DATA:levelingCurve.lua]
12:51:34.89   Error loading [DATA:levelingCurve.lua]
12:51:34.89   Error loading [DATA:levelingCurve.lua]
12:51:34.89   Error loading [DATA:levelingCurve.lua]
12:51:34.89   Error loading [DATA:levelingCurve.lua]
12:51:34.89   MOD - Setting player (0) race to: allies_soviets
12:51:34.89   MOD - Setting player (0) race to: 2
12:51:34.89   MOD - Setting player (1) race to: allies_soviets
12:51:34.89   MOD - Setting player (1) race to: 2
12:51:34.89   MOD - Setting player (2) race to: allies_soviets
12:51:34.89   MOD - Setting player (2) race to: 2
12:51:34.89   MOD - Setting player (3) race to: axis
12:51:34.89   MOD - Setting player (3) race to: 3
12:51:34.89   MOD - Setting player (4) race to: axis
12:51:34.89   MOD - Setting player (4) race to: 3
12:51:34.89   MOD - Setting player (5) race to: axis
12:51:34.89   MOD - Setting player (5) race to: 3
12:51:34.89   Activating screen: MessageBoxPopup
12:51:34.89   Session is marking the local peer PeerID 1 for death
12:51:34.89   Session::GetEvent DestroyPeer success Peer 1 removed
12:51:34.89   Session::DestroyPeer - deallocating peer 1
12:51:34.89   Session - Requested Disconnect for connectionID 2
12:51:34.89   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
12:51:34.89   Session - Requested Disconnect for connectionID 3
12:51:34.89   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
12:51:34.89   AdvertisementInternal::Process - EVENT_DESTROYPEER
12:51:34.89   Destroyed Matchinfo
12:51:34.90   APP -- Game Start
12:51:34.90   Sent message game CompanyOfHeroes allowtraffic
12:51:34.90   GAME -- Setting campaign state to 'dlc1'
12:51:34.90   GAME -- Closing state 'dlc1'
12:51:34.90   GAME -- Setting campaign state to 'dlc2'
12:51:34.90   GAME -- Closing state 'dlc2'
12:51:34.91   GAME -- Setting campaign state to 'dlc3'
12:51:34.91   GAME -- Closing state 'dlc3'
12:51:34.91   MessageInternal::DestroyChannel: Destroyed channel 534d5347
12:51:34.92   GAME -- Ending FE
12:51:34.92   UIFrontEnd - Unloading Front End
12:51:34.94   SOUND -- Shutting down ...
12:51:34.99   SOUND -- Shutdown completed!
12:51:35.02
12:51:35.02   GAME -- *** Beginning mission 6p_stalingrad (1 Humans, 5 Computers) ***
12:51:35.02
12:51:35.59   GAME -- Recording game
12:51:35.65   Activating screen: GameLoadScreen
12:51:35.66   ReportGameStartStats - no connection to server unable to report
12:51:35.66   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
12:51:35.66   PeerRemoveAll - flushing local session peer data
12:51:35.66   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
12:51:35.66   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
12:51:36.16   THREAD: Hyper-Threading Technology Processors are not detected.
12:51:36.26   SOUND -- Initializing ...
12:51:36.98   SOUND -- Initialization completed!
12:51:37.00   PHYSICS: detected processor(s) capable of handling 4 threads.
12:51:37.00   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\6p_stalingrad'
12:51:37.00   MOD -- Using Mod 'Eastern_Front'
12:51:37.03   Unable to load/parse precache file [DATA:scenarios\mp\6p_stalingrad_precache.lua]
12:51:37.16   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
12:51:37.16   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
12:51:40.59   GameObjLoader - upgrading load_count from 0 to 1244
12:51:44.12   GameObjLoader - upgrading load_count from 1244 to 2071
12:51:44.20   PHYSICS -- Created node factory 'HVOK'
12:51:44.20   PHYSICS -- Created node factory 'DMMY'
12:51:59.14   GameObjLoader - upgrading load_count from 1843 to 5181
12:52:04.56   GameObjLoader 0e167e40 - resetting counters
12:52:04.56   GameObjLoader 0e167e40 - LOAD_DONE
12:52:04.56   GAME - SessionSetup
12:52:04.70   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
12:52:04.70   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
12:52:04.70   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
12:52:06.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.1/0.1, #p/sec[s/r] = 0.3/0.8, max unsent 0, version err 0, merge 0
12:52:08.53   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.54   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.54   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.54   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.56   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.56   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.61   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.61   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.77   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.77   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.80   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.80   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.80   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.80   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.80   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.80   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.80   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.81   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.81   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.81   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.81   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.81   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:08.81   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
12:52:09.46   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
12:52:10.25   GAME - CreateGEWorld in 5691 ms
12:52:10.25   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
12:52:10.37   GAME - SessionSetup finished in 5812 ms
12:52:10.38   GAME - WaterReflectionManagerSetup
12:52:10.38   GAME - WaterReflectionManagerSetup finished in 0 ms
12:52:11.22   MessageInternal::CreateChannel: Created channel 474d4343
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x06a6c9b0
[Cope FactionFix] - patched @0x6c1f5491
[Cope FactionFix] - hooked @0x6c1f5492
[Cope FactionFix] - patched @0x6c1f4a07
[Cope FactionFix] - hooked @0x6c1f4a07
[Cope FactionFix] - Hook installed
12:52:11.39   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
12:52:12.24   Error: trying execute a Health command but the entity doesn't have a HealthExt
12:52:12.34   MOD -- Player  (unused player) (frame 0) (KillPlayer)
12:52:12.34   MOD -- Player  (unused player) (frame 0) (KillPlayer)
12:52:13.12   MessageInternal::CreateChannel: Created channel 4d4f444d
12:52:13.96   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
12:52:13.97   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
12:52:13.97   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
12:52:13.97   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
12:52:13.97   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
12:52:14.57   SPEECHMANAGER -- Loaded in 0.556281 seconds
12:52:16.68   GameObjLoader - upgrading load_count from 0 to 383
12:52:18.57   GameObjLoader 0e167fa0 - resetting counters
12:52:18.57   GameObjLoader 0e167fa0 - LOAD_DONE
12:52:20.64   PreloadResources took 2007ms.
12:52:20.74   GAME -- Loading completed (45 seconds)
12:52:20.74   SIM -- Setting SyncErrorChecking level to None
12:52:24.61   Activating screen: GameScreen
12:52:24.61   Activating screen: Decorators
12:52:24.61   Activating screen: Taskbar
12:52:24.61   Activating screen: SubtitleScreen
12:52:24.61   Activating screen: TextOverlayScreen
12:52:24.80   PerformanceRecorder::StartRecording for game size 6
12:52:24.80   GAME -- Starting mission...
12:52:25.99   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
12:52:25.99   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
12:52:25.99   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
12:52:25.99   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
12:52:25.99   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
12:52:30.57   Warning: binding repeat_2(Ability: abilities\reenable_capture_ability_engineers) -- ui index '0' out of bounds; range is [1, 12]
12:52:30.65   Warning: binding repeat_5(Ability: abilities\smg_mp40) -- ui index '0' out of bounds; range is [1, 12]
12:52:30.74   Warning: non auto-match upgrade not found in AE, tuning
12:52:33.56   Activating screen: Command_Tree
12:52:34.89   Activating screen: Command_Branch
12:52:39.79   Activating screen: Command_Branch
12:52:56.84   Activating screen: NewObjective
12:53:07.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
12:53:31.87   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
12:54:08.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
12:55:09.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
12:55:50.76   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
12:56:10.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
12:56:42.03   Warning: binding repeat_3(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
12:57:11.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
12:58:12.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
12:58:17.78   Activating screen: Command_Branch
12:58:23.98   Warning: binding repeat_4(Production Item: sbps\races\axis\vehicles\halftrack_squad_with_pioneer) -- ui index '0' out of bounds; range is [1, 12]
12:59:13.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
12:59:40.83   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
12:59:40.83   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
12:59:40.83   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.
12:59:42.06   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
12:59:42.06   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
12:59:42.06   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.
12:59:43.44   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
12:59:43.44   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
12:59:43.44   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.
12:59:44.94   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
12:59:44.94   Muting spew of bind updater.  Fix art and re-test.
13:00:14.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
13:00:33.52   Activating screen: Command_Branch
13:01:15.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
13:02:16.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
13:03:06.60   Activating screen: Command_Branch
13:03:17.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
13:04:18.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
13:05:19.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
13:06:20.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
13:07:21.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
SIM -- Attempting to query bag not associated with this group type.
Group is of type 8.  Query is for type 1.  Group name: 'sbps\races\allies_soviets\soldiers\soviet_stsappers_squad'
-- FATAL EXIT --
simengine/propertysystem/propertybaggroup.h/85:!
--stack trace--

0x6FBB24CD: LuaBinding::Obj::Dispatcher                 (D:\Coh Tov\LuaConfig.dll)
0x6FB9FA30: lua_yield                                   (D:\Coh Tov\LuaConfig.dll)
0x6FBA1AFB: lua_resume                                  (D:\Coh Tov\LuaConfig.dll)
0x6FB9FA9E: lua_yield                                   (D:\Coh Tov\LuaConfig.dll)
0x6FB9FBD7: lua_resume                                  (D:\Coh Tov\LuaConfig.dll)
0x6FB97FBE: lua_pcall                                   (D:\Coh Tov\LuaConfig.dll)
0x6FBAD906: luax_callalert                              (D:\Coh Tov\LuaConfig.dll)
0x6F6A786C: MarkerObj::IsPersistent                     (D:\Coh Tov\SimEngine.dll)
