-- Log file for all dbTracef messages --

09:15:45.92   NetworkManager::Create - creating network manager
09:15:45.92   Read 269 bytes from network datastore login_cache.bin
09:15:45.92   Read 52 bytes from network datastore global_cache.bin
09:15:45.92   Read 28 bytes from network datastore ping_cache.bin
09:15:45.92   QuazalInitializer - static initializing Quazal library
09:15:45.92   PingCache - populating cache with 0 pings
09:15:46.18   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
09:15:46.24   WinTransport - CreateSocket exclusive broadcast socket was available.
09:15:46.24   WinTransport - CreateSocket listening for broadcasts on default port
09:15:46.34   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
09:15:46.34   WinTransport - Host IP Address #0: 5.3.208.164
09:15:46.34   WinTransport - WARNING, MultipleNetwork adapters may cause problems
09:15:46.34   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
09:15:46.34   WinTransport - Interface #1: ip:192.168.1.100, broadcast:192.168.1.100, flags=IFF_BROADCAST IFF_MULTICAST
09:15:46.34   WinTransport - Interface #2: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
09:15:46.34   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:15:46.34   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
09:15:46.34   SessionManager - Peer Header Size = 16 bytes
09:15:46.34   SessionManager - Game Data overhead = 7 bytes
09:15:46.34   SessionManager - Proxy overhead = 7 bytes
09:15:46.34   MessageInternal::CreateChannel: Created channel 47535450
09:15:46.34   Session::Initialize - info, initializing session object, using threads.
09:15:46.34   SessionManager::RegisterSession - Registering new session 07882e40
09:15:46.34   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:15:46.34   AutomatchInternal: Instantiating
09:15:46.34   PartyInternal: Instantiating
09:15:46.34   MessageInternal::CreateChannel: Created channel 50525459
09:15:46.34   MessageInternal::CreateChannel: Created channel 51434b4d
09:15:46.34   Net::ThreadFunction - Entering network thread function...
09:15:46.37   Transport - Largest received is now 19
09:15:46.37   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
09:15:46.38   Transport - Largest sent is now 19
09:15:46.41   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:15:46.41   MessageInternal::CreateChannel: Created channel 534d5347
09:15:46.41   MessageInternal::CreateChannel: Created channel 474d4343
09:15:46.41   MessageInternal::CreateChannel: Created channel 474f424a
09:15:46.41   MessageInternal::CreateChannel: Created channel 4d4f444d
09:15:46.41   MessageInternal::CreateChannel: Created channel 53594e43
09:15:46.41   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:15:46.41   MessageInternal::DestroyChannel: Destroyed channel 474d4343
09:15:46.41   MessageInternal::DestroyChannel: Destroyed channel 474f424a
09:15:46.41   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
09:15:46.41   MessageInternal::DestroyChannel: Destroyed channel 53594e43
09:15:46.41   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
09:15:49.28   DLLDriverLinker -- Adding driver 'spDx10.dll'.
09:15:49.28   DLLDriverLinker -- Adding driver 'spDx9.dll'.
09:15:49.28   DLLDriverLinker -- 2 DLL drivers found.
09:15:49.35   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
09:15:51.14   DLLDriverLinker -- 2 DLL drivers found.
09:15:51.25   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
09:15:51.25   GAME -- Resolution set to 1024x768 (fullscreen).
09:15:51.28   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
09:15:51.28   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
09:15:51.28   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
09:15:51.28   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
09:15:51.84   SPDx9 -- 1774MB available Texture Memory
09:15:51.84   ShaderDatabase: using shader profile [ps30]
09:15:52.33   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
09:15:52.58   GameObjLoader 0a09e4e8 - resetting counters
09:15:52.58   GameObjLoader 0a09e4e8 - Created loader
09:15:52.58   GameObjLoader 0a09e648 - resetting counters
09:15:52.58   GameObjLoader 0a09e648 - Created loader
09:16:08.08   GAME -- Beginning FE
09:16:08.08   Sent message game CompanyOfHeroes started 952 602 allowtraffic
09:16:08.08   RemoteDLManager - Connection Restored.
09:16:08.08   UIFrontEnd - Loading Front End
09:16:08.08   THREAD: Hyper-Threading Technology Processors are not detected.
09:16:08.19   SOUND -- Initializing ...
09:16:08.27   INNIMapDCA Key not found: sp_speechducker::time
09:16:08.80   SOUND -- Initialization completed!
09:16:08.80   UIFrontEnd - Initializing Forms
09:16:10.54   CampaignFilter::BindFilterSpecificWidgets()
09:16:10.70   Activating screen: MovieScreen
09:16:10.70   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
09:16:35.77   Activating screen: AppLoadingForm
09:16:35.77   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:16:36.54   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
09:16:36.54   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
09:16:36.55   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
09:16:36.55   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
09:16:36.55   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
09:16:36.55   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
09:16:37.04   GAME -- Using player profile NGOCQUANG-PC
09:16:40.13   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
09:16:41.02   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
09:16:43.40   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
09:16:43.40   RendezvousManager: CreateSession - starting profile=Guest login
09:16:43.45   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
09:16:43.45   RendezvousManager - unable to connect to the server as guest
09:16:43.47   OnConnect: connect failure
09:16:43.47   RendezvousManager::Shutdown - deleting instance
09:16:43.47   RendezvousManager - terminating all server calls in progress
09:16:43.47   CallManager - terminating all server calls in progress (1 in progress)
09:16:43.47   RendezvousManager - destroying chat handler
09:16:43.47   ~RendezvousManager - m_state = 7, no need for server disconnect
09:16:43.49   OnConnect: this wasnt a reconnect, no need for autologin
09:16:43.50   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:16:43.50   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
09:16:43.50   Activating screen: FEMovie
09:16:43.50   Activating screen: OnlineWidget
09:16:43.50   Activating screen: RelicOnlineLogin
09:16:43.57   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:16:43.57   You have a valid version of the game.
09:16:43.58   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
09:16:43.58   installed_products = ( DLC1 DLC2 DLC3 )
09:16:43.58   OnLogin: no previous login, auto selecting profile not required
09:16:43.58   Activating screen: MessageBoxPopup
09:16:43.58   Activating screen: MessageBoxPopup
09:16:43.58   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
09:16:47.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 0.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:17:14.00   Beginning media verification...
09:17:14.00   Validator type : validators\udro\udro.dll
09:17:14.00   Activating screen: MessageBoxPopup
09:17:14.03   Activating screen: FE_mm_01
09:17:14.05   GAME -- Setting campaign state to 'dlc1'
09:17:14.05   GAME -- Closing state 'dlc1'
09:17:14.05   GAME -- Setting campaign state to 'dlc2'
09:17:14.05   GAME -- Closing state 'dlc2'
09:17:14.05   GAME -- Setting campaign state to 'dlc3'
09:17:14.05   GAME -- Closing state 'dlc3'
09:17:15.73   FEHelpers::DoScenarioSelection - Could not find current profile, using first scenario
09:17:15.73   Activating screen: MessageBoxPopup
09:17:15.73   Created Matchinfo
09:17:15.73   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:17:15.73   starting LAN hosting
09:17:15.76   OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:17:15.76   starting local hosting
09:17:15.77   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:17:15.77   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:17:15.77   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
09:17:15.77   Session::Host sid = F386CB158F7691E2, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
09:17:15.77   ValidateCustomData: called with 217 bytes of custom data
09:17:15.77   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
09:17:15.77   AdvertisementInternal::Process - EVENT_NEWPEER
09:17:15.77   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
09:17:15.80   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
09:17:15.80   hosting - Session is connected
09:17:15.80   Net::Session::SetVisible - session is set to VISIBLE.
09:17:15.81   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:5.3.208.164:6112; (ping=0ms) 100.00%, pending=0, dead=0
09:17:15.81   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=1/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
09:17:15.82   Transport - Largest received is now 439
09:17:15.82   hosting completed successfully
09:17:15.82   HostAsync - completed with HostResult = 0
09:17:15.82   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
09:17:15.82   Activating screen: OnlineGameSetup
09:17:15.82   MessageInternal::CreateChannel: Created channel 534d5347
09:17:15.82   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:15.82   MatchInternal::SetMatchType - new type 14 - updating server
09:17:15.84   Transport - Largest received is now 531
09:17:15.85   SetVisible called while !IsConnected
09:17:15.85   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
09:17:15.85   Activating screen: RelicOnlineChat
09:17:15.85   Activating screen: RelicOnlineNewsScreen
09:17:15.85   Activating screen: RelicOnlineStatsScreen
09:17:15.85   Activating screen: Achievements
09:17:15.85   GAME -- Setting campaign state to 'dlc1'
09:17:15.85   GAME -- Closing state 'dlc1'
09:17:15.86   GAME -- Setting campaign state to 'dlc1'
09:17:15.86   GAME -- Closing state 'dlc1'
09:17:15.86   GAME -- Setting campaign state to 'dlc2'
09:17:15.86   GAME -- Closing state 'dlc2'
09:17:15.86   GAME -- Setting campaign state to 'dlc3'
09:17:15.86   GAME -- Closing state 'dlc3'
09:17:15.86   GAME -- Setting campaign state to 'dlc1'
09:17:15.86   GAME -- Closing state 'dlc1'
09:17:15.87   Activating screen: GameHistory
09:17:15.87   GAME -- Setting campaign state to 'dlc1'
09:17:15.87   GAME -- Closing state 'dlc1'
09:17:15.87   GAME -- Setting campaign state to 'dlc2'
09:17:15.87   GAME -- Closing state 'dlc2'
09:17:15.87   GAME -- Setting campaign state to 'dlc3'
09:17:15.87   GAME -- Closing state 'dlc3'
09:17:15.88   Transport - Largest received is now 1168
09:17:15.88   Activating screen: OnlineGameSetup
09:17:15.88   Activating screen: RelicOnlineTabs
09:17:15.88   AutomatchInternal::OnHostComplete - Completed Host with success=1
09:17:15.88   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
09:17:15.88   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
09:17:15.88   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:15.88   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:15.88   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
09:17:15.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:15.99   GAME -- Setting campaign state to 'dlc1'
09:17:15.99   GAME -- Closing state 'dlc1'
09:17:15.99   GAME -- Setting campaign state to 'dlc2'
09:17:15.99   GAME -- Closing state 'dlc2'
09:17:15.99   GAME -- Setting campaign state to 'dlc3'
09:17:15.99   GAME -- Closing state 'dlc3'
09:17:16.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:17.40   Activating screen: RaceSelectionPopup
09:17:18.23   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:18.23   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:18.23   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
09:17:18.25   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:18.28   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:24.54   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:24.54   Net::Session::SetVisible - session is set to VISIBLE.
09:17:24.54   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:24.63   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:24.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:25.87   Activating screen: DynamicPopupMenu
09:17:26.69   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:26.69   Net::Session::SetVisible - session is set to VISIBLE.
09:17:26.69   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:26.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:26.73   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:27.32   Activating screen: RaceSelectionPopup
09:17:28.31   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:28.31   Net::Session::SetVisible - session is set to VISIBLE.
09:17:28.31   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:28.31   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:28.35   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:28.90   Activating screen: DynamicPopupMenu
09:17:30.04   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:30.04   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:30.05   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:30.05   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:30.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:30.60   Activating screen: RaceSelectionPopup
09:17:31.35   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:31.35   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:31.35   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:31.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:31.39   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:32.07   Activating screen: DynamicPopupMenu
09:17:32.85   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:32.85   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:32.85   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:32.87   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:32.89   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:33.57   Activating screen: DynamicPopupMenu
09:17:34.38   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:34.38   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:34.38   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:34.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:34.42   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:35.11   Activating screen: DynamicPopupMenu
09:17:35.89   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:35.89   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:35.89   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:35.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:35.95   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:38.03   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:38.03   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:38.03   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:38.05   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:38.08   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:39.96   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:39.96   Net::Session::SetVisible - session is set to INVISIBLE.
09:17:39.96   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:17:39.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:40.02   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:41.87   GameSetupForm - No win/loss reporting and only a single player, disconnecting
09:17:41.87   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:17:41.87   SetVisible called while !IsConnected
09:17:41.87   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:41.88   GameSetupForm - Starting game
09:17:41.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:17:41.88   PopulateGameInfo - random seed:[1308277061], guid:[{1ec3429b-90c5-4b70-abd5-a0d0d3304135}], sync level:[2]
09:17:41.88   Error loading [DATA:levelingCurve.lua]
09:17:41.88   Error loading [DATA:levelingCurve.lua]
09:17:41.89   Error loading [DATA:levelingCurve.lua]
09:17:41.89   Error loading [DATA:levelingCurve.lua]
09:17:41.89   Error loading [DATA:levelingCurve.lua]
09:17:41.89   Error loading [DATA:levelingCurve.lua]
09:17:41.89   MOD - Setting player (0) race to: allies_soviets
09:17:41.89   MOD - Setting player (0) race to: 2
09:17:41.89   MOD - Setting player (1) race to: allies_soviets
09:17:41.89   MOD - Setting player (1) race to: 2
09:17:41.89   MOD - Setting player (2) race to: allies_soviets
09:17:41.89   MOD - Setting player (2) race to: 2
09:17:41.89   MOD - Setting player (3) race to: axis
09:17:41.89   MOD - Setting player (3) race to: 3
09:17:41.89   MOD - Setting player (4) race to: axis
09:17:41.89   MOD - Setting player (4) race to: 3
09:17:41.89   MOD - Setting player (5) race to: axis
09:17:41.89   MOD - Setting player (5) race to: 3
09:17:41.89   Activating screen: MessageBoxPopup
09:17:41.89   Session is marking the local peer PeerID 1 for death
09:17:41.89   Session::GetEvent DestroyPeer success Peer 1 removed
09:17:41.89   Session::DestroyPeer - deallocating peer 1
09:17:41.89   Session - Requested Disconnect for connectionID 2
09:17:41.89   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:17:41.89   Session - Requested Disconnect for connectionID 3
09:17:41.89   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:17:41.89   AdvertisementInternal::Process - EVENT_DESTROYPEER
09:17:41.89   Destroyed Matchinfo
09:17:41.90   APP -- Game Start
09:17:41.90   Sent message game CompanyOfHeroes allowtraffic
09:17:41.90   GAME -- Setting campaign state to 'dlc1'
09:17:41.90   GAME -- Closing state 'dlc1'
09:17:41.90   GAME -- Setting campaign state to 'dlc2'
09:17:41.90   GAME -- Closing state 'dlc2'
09:17:41.91   GAME -- Setting campaign state to 'dlc3'
09:17:41.91   GAME -- Closing state 'dlc3'
09:17:41.91   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:17:41.93   GAME -- Ending FE
09:17:41.93   UIFrontEnd - Unloading Front End
09:17:41.94   SOUND -- Shutting down ...
09:17:42.03   SOUND -- Shutdown completed!
09:17:42.04
09:17:42.04   GAME -- *** Beginning mission 6p_stalingrad (1 Humans, 5 Computers) ***
09:17:42.04
09:17:42.68   GAME -- Recording game
09:17:42.75   Activating screen: GameLoadScreen
09:17:42.75   ReportGameStartStats - no connection to server unable to report
09:17:42.75   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:17:42.75   PeerRemoveAll - flushing local session peer data
09:17:42.75   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:17:42.75   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
09:17:43.24   THREAD: Hyper-Threading Technology Processors are not detected.
09:17:43.32   SOUND -- Initializing ...
09:17:44.05   SOUND -- Initialization completed!
09:17:44.12   PHYSICS: detected processor(s) capable of handling 4 threads.
09:17:44.13   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\6p_stalingrad'
09:17:44.13   MOD -- Using Mod 'Eastern_Front'
09:17:44.16   Unable to load/parse precache file [DATA:scenarios\mp\6p_stalingrad_precache.lua]
09:17:44.27   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:17:44.28   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:17:47.78   GameObjLoader - upgrading load_count from 0 to 1240
09:17:48.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
09:17:51.82   GameObjLoader - upgrading load_count from 1240 to 2071
09:17:51.91   PHYSICS -- Created node factory 'HVOK'
09:17:51.91   PHYSICS -- Created node factory 'DMMY'
09:18:16.58   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:18:34.53   GameObjLoader - upgrading load_count from 14 to 4902
09:18:42.15   GameObjLoader 0a09e4e8 - resetting counters
09:18:42.15   GameObjLoader 0a09e4e8 - LOAD_DONE
09:18:42.15   GAME - SessionSetup
09:18:42.31   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
09:18:42.31   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
09:18:42.31   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
09:18:45.20   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.20   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.21   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.21   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.22   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.23   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.28   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.28   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.44   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.44   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.47   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.47   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.47   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.47   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.47   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.47   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.47   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.48   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.48   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.48   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.48   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.48   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:45.48   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
09:18:46.92   GAME - CreateGEWorld in 4770 ms
09:18:46.93   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:18:47.00   GAME - SessionSetup finished in 4850 ms
09:18:47.02   GAME - WaterReflectionManagerSetup
09:18:47.02   GAME - WaterReflectionManagerSetup finished in 0 ms
09:18:47.81   MessageInternal::CreateChannel: Created channel 474d4343
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x06588020
[Cope FactionFix] - patched @0x6dd15491
[Cope FactionFix] - hooked @0x6dd15492
[Cope FactionFix] - patched @0x6dd14a07
[Cope FactionFix] - hooked @0x6dd14a07
[Cope FactionFix] - Hook installed
09:18:48.08   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
09:18:48.95   Error: trying execute a Health command but the entity doesn't have a HealthExt
09:18:49.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:18:49.05   MOD -- Player  (unused player) (frame 0) (KillPlayer)
09:18:49.05   MOD -- Player  (unused player) (frame 0) (KillPlayer)
09:18:49.78   MessageInternal::CreateChannel: Created channel 4d4f444d
09:18:50.64   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:18:50.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:18:50.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:18:50.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:18:50.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:18:51.24   SPEECHMANAGER -- Loaded in 0.549206 seconds
09:18:51.96   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:18:53.33   GameObjLoader - upgrading load_count from 0 to 383
09:18:55.22   GameObjLoader 0a09e648 - resetting counters
09:18:55.22   GameObjLoader 0a09e648 - LOAD_DONE
09:18:57.65   PreloadResources took 2370ms.
09:18:57.88   GAME -- Loading completed (75 seconds)
09:18:57.88   SIM -- Setting SyncErrorChecking level to None
09:19:11.68   Activating screen: GameScreen
09:19:11.68   Activating screen: Decorators
09:19:11.68   Activating screen: Taskbar
09:19:11.68   Activating screen: SubtitleScreen
09:19:11.68   Activating screen: TextOverlayScreen
09:19:11.84   PerformanceRecorder::StartRecording for game size 6
09:19:11.84   GAME -- Starting mission...
09:19:13.19   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:19:13.19   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:19:13.19   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:19:13.19   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:19:13.19   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:19:17.87   Warning: non auto-match upgrade not found in AE, tuning
09:19:20.18   Activating screen: pause_menu
09:19:20.20   GAME -- SimulationController::Pause 0
09:19:21.48   Activating screen: pause_options
09:19:30.34   GAME -- SimulationController::Pause 1
09:19:36.67   Activating screen: Command_Tree
09:19:37.47   Activating screen: Command_Branch
09:19:50.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:19:53.08   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
09:20:26.89   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
09:20:45.46   Warning: binding repeat_1(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12]
09:20:51.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:21:50.46   Activating screen: Command_Branch
09:21:52.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:22:53.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:22:57.63   Activating screen: Command_Branch
09:23:54.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:24:55.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:25:02.34   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
09:25:02.34   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
09:25:02.34   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.
09:25:17.85   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
09:25:17.85   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
09:25:17.85   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.
09:25:31.28   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
09:25:51.89   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
09:25:56.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:26:03.14   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
09:26:03.14   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
09:26:03.14   Muting spew of bind updater.  Fix art and re-test.
09:26:57.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:27:58.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:28:59.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
09:30:00.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:31:01.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:31:01.88   Activating screen: Command_Branch
09:32:02.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:33:03.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
09:34:04.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:35:05.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:36:06.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:37:07.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:38:08.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:38:16.85   Activating screen: Command_Branch
09:39:09.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:39:13.67   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
09:40:10.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.4/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:41:11.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.4/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--

0x704424CD: LuaBinding::Obj::Dispatcher                 (D:\Coh Tov\LuaConfig.dll)
0x7042FA30: lua_yield                                   (D:\Coh Tov\LuaConfig.dll)
0x70431AFB: lua_resume                                  (D:\Coh Tov\LuaConfig.dll)
0x7042FA9E: lua_yield                                   (D:\Coh Tov\LuaConfig.dll)
0x7042FBD7: lua_resume                                  (D:\Coh Tov\LuaConfig.dll)
0x70427FBE: lua_pcall                                   (D:\Coh Tov\LuaConfig.dll)
0x7043D906: luax_callalert                              (D:\Coh Tov\LuaConfig.dll)
0x6FF0786C: MarkerObj::IsPersistent                     (D:\Coh Tov\SimEngine.dll)
