-- Log file for all dbTracef messages --

09:41:55.06   NetworkManager::Create - creating network manager
09:41:55.06   Read 269 bytes from network datastore login_cache.bin
09:41:55.06   Read 52 bytes from network datastore global_cache.bin
09:41:55.06   Read 28 bytes from network datastore ping_cache.bin
09:41:55.06   QuazalInitializer - static initializing Quazal library
09:41:55.06   PingCache - populating cache with 0 pings
09:41:55.15   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
09:41:55.20   WinTransport - CreateSocket exclusive broadcast socket was available.
09:41:55.20   WinTransport - CreateSocket listening for broadcasts on default port
09:41:55.21   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
09:41:55.21   WinTransport - Host IP Address #0: 5.3.208.164
09:41:55.21   WinTransport - WARNING, MultipleNetwork adapters may cause problems
09:41:55.21   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
09:41:55.21   WinTransport - Interface #1: ip:192.168.1.100, broadcast:192.168.1.100, flags=IFF_BROADCAST IFF_MULTICAST
09:41:55.21   WinTransport - Interface #2: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
09:41:55.21   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:41:55.21   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
09:41:55.21   SessionManager - Peer Header Size = 16 bytes
09:41:55.21   SessionManager - Game Data overhead = 7 bytes
09:41:55.21   SessionManager - Proxy overhead = 7 bytes
09:41:55.21   MessageInternal::CreateChannel: Created channel 47535450
09:41:55.21   Session::Initialize - info, initializing session object, using threads.
09:41:55.21   SessionManager::RegisterSession - Registering new session 07982e40
09:41:55.21   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:41:55.21   AutomatchInternal: Instantiating
09:41:55.21   PartyInternal: Instantiating
09:41:55.21   MessageInternal::CreateChannel: Created channel 50525459
09:41:55.21   MessageInternal::CreateChannel: Created channel 51434b4d
09:41:55.21   Net::ThreadFunction - Entering network thread function...
09:41:55.21   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:41:55.21   MessageInternal::CreateChannel: Created channel 534d5347
09:41:55.21   MessageInternal::CreateChannel: Created channel 474d4343
09:41:55.21   MessageInternal::CreateChannel: Created channel 474f424a
09:41:55.21   MessageInternal::CreateChannel: Created channel 4d4f444d
09:41:55.21   MessageInternal::CreateChannel: Created channel 53594e43
09:41:55.21   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:41:55.21   MessageInternal::DestroyChannel: Destroyed channel 474d4343
09:41:55.21   MessageInternal::DestroyChannel: Destroyed channel 474f424a
09:41:55.21   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
09:41:55.21   MessageInternal::DestroyChannel: Destroyed channel 53594e43
09:41:55.21   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
09:41:55.24   Transport - Largest received is now 19
09:41:55.24   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
09:41:55.26   Transport - Largest sent is now 19
09:41:58.11   DLLDriverLinker -- Adding driver 'spDx10.dll'.
09:41:58.11   DLLDriverLinker -- Adding driver 'spDx9.dll'.
09:41:58.11   DLLDriverLinker -- 2 DLL drivers found.
09:41:58.16   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
09:42:00.31   DLLDriverLinker -- 2 DLL drivers found.
09:42:00.42   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
09:42:00.42   GAME -- Resolution set to 1024x768 (fullscreen).
09:42:00.50   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
09:42:00.50   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
09:42:00.50   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
09:42:00.50   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
09:42:01.06   SPDx9 -- 1774MB available Texture Memory
09:42:01.06   ShaderDatabase: using shader profile [ps30]
09:42:01.56   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
09:42:01.78   GameObjLoader 041cbdc0 - resetting counters
09:42:01.78   GameObjLoader 041cbdc0 - Created loader
09:42:01.78   GameObjLoader 041cbf20 - resetting counters
09:42:01.78   GameObjLoader 041cbf20 - Created loader
09:42:17.30   GAME -- Beginning FE
09:42:17.30   Sent message game CompanyOfHeroes started 2692 602 allowtraffic
09:42:17.30   RemoteDLManager - Connection Restored.
09:42:17.30   UIFrontEnd - Loading Front End
09:42:17.30   THREAD: Hyper-Threading Technology Processors are not detected.
09:42:17.41   SOUND -- Initializing ...
09:42:17.48   INNIMapDCA Key not found: sp_speechducker::time
09:42:17.97   SOUND -- Initialization completed!
09:42:17.97   UIFrontEnd - Initializing Forms
09:42:19.64   CampaignFilter::BindFilterSpecificWidgets()
09:42:19.77   Activating screen: MovieScreen
09:42:19.77   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
09:42:44.70   Activating screen: AppLoadingForm
09:42:44.70   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:42:45.29   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
09:42:45.29   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
09:42:45.30   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
09:42:45.30   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
09:42:45.30   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
09:42:45.30   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
09:42:45.67   GAME -- Using player profile NGOCQUANG-PC
09:42:48.78   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
09:42:49.68   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
09:42:51.30   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
09:42:51.30   RendezvousManager: CreateSession - starting profile=Guest login
09:42:51.35   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
09:42:51.35   RendezvousManager - unable to connect to the server as guest
09:42:51.37   OnConnect: connect failure
09:42:51.37   RendezvousManager::Shutdown - deleting instance
09:42:51.37   RendezvousManager - terminating all server calls in progress
09:42:51.37   CallManager - terminating all server calls in progress (1 in progress)
09:42:51.37   RendezvousManager - destroying chat handler
09:42:51.37   ~RendezvousManager - m_state = 7, no need for server disconnect
09:42:51.39   OnConnect: this wasnt a reconnect, no need for autologin
09:42:51.40   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:42:51.41   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
09:42:51.41   Activating screen: FEMovie
09:42:51.41   Activating screen: OnlineWidget
09:42:51.41   Activating screen: RelicOnlineLogin
09:42:51.45   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:42:51.45   You have a valid version of the game.
09:42:51.46   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
09:42:51.46   installed_products = ( DLC1 DLC2 DLC3 )
09:42:51.46   OnLogin: no previous login, auto selecting profile not required
09:42:51.46   Activating screen: MessageBoxPopup
09:42:51.46   Activating screen: MessageBoxPopup
09:42:51.46   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
09:42:56.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:43:39.91   Beginning media verification...
09:43:39.91   Validator type : validators\udro\udro.dll
09:43:39.91   Activating screen: MessageBoxPopup
09:43:42.06   Activating screen: FE_mm_01
09:43:42.06   GAME -- Setting campaign state to 'dlc1'
09:43:42.06   GAME -- Closing state 'dlc1'
09:43:42.06   GAME -- Setting campaign state to 'dlc2'
09:43:42.06   GAME -- Closing state 'dlc2'
09:43:42.07   GAME -- Setting campaign state to 'dlc3'
09:43:42.07   GAME -- Closing state 'dlc3'
09:43:56.72   Activating screen: OptionsMenu
09:43:56.72   THREAD: Hyper-Threading Technology Processors are not detected.
09:43:56.73   THREAD: Hyper-Threading Technology Processors are not detected.
09:43:57.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 0.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:44:25.18   Activating screen: FE_mm_01
09:44:25.18   GAME -- Setting campaign state to 'dlc1'
09:44:25.18   GAME -- Closing state 'dlc1'
09:44:25.19   GAME -- Setting campaign state to 'dlc2'
09:44:25.19   GAME -- Closing state 'dlc2'
09:44:25.19   GAME -- Setting campaign state to 'dlc3'
09:44:25.19   GAME -- Closing state 'dlc3'
09:44:26.93   Activating screen: MessageBoxPopup
09:44:26.93   Created Matchinfo
09:44:26.93   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:44:26.93   starting LAN hosting
09:44:26.96   OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:44:26.96   starting local hosting
09:44:26.96   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:44:26.96   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:44:26.96   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
09:44:26.96   Session::Host sid = 2B61FDFDEC5B54CC, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
09:44:26.96   ValidateCustomData: called with 217 bytes of custom data
09:44:26.96   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
09:44:26.96   AdvertisementInternal::Process - EVENT_NEWPEER
09:44:26.96   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
09:44:26.98   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
09:44:26.98   hosting - Session is connected
09:44:26.98   Net::Session::SetVisible - session is set to VISIBLE.
09:44:26.99   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:44:26.99   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:44:26.99   hosting completed successfully
09:44:26.99   HostAsync - completed with HostResult = 0
09:44:27.00   Transport - Largest received is now 465
09:44:27.00   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
09:44:27.00   Activating screen: OnlineGameSetup
09:44:27.00   MessageInternal::CreateChannel: Created channel 534d5347
09:44:27.00   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:27.00   MatchInternal::SetMatchType - new type 14 - updating server
09:44:27.01   SetVisible called while !IsConnected
09:44:27.01   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:27.01   Activating screen: RelicOnlineChat
09:44:27.01   Activating screen: RelicOnlineNewsScreen
09:44:27.01   Activating screen: RelicOnlineStatsScreen
09:44:27.01   Activating screen: Achievements
09:44:27.02   Transport - Largest received is now 521
09:44:27.02   GAME -- Setting campaign state to 'dlc1'
09:44:27.02   GAME -- Closing state 'dlc1'
09:44:27.02   GAME -- Setting campaign state to 'dlc1'
09:44:27.02   GAME -- Closing state 'dlc1'
09:44:27.02   GAME -- Setting campaign state to 'dlc2'
09:44:27.03   GAME -- Closing state 'dlc2'
09:44:27.03   GAME -- Setting campaign state to 'dlc3'
09:44:27.03   GAME -- Closing state 'dlc3'
09:44:27.03   GAME -- Setting campaign state to 'dlc1'
09:44:27.03   GAME -- Closing state 'dlc1'
09:44:27.03   Activating screen: GameHistory
09:44:27.03   GAME -- Setting campaign state to 'dlc1'
09:44:27.04   Transport - Largest received is now 1151
09:44:27.04   GAME -- Closing state 'dlc1'
09:44:27.04   GAME -- Setting campaign state to 'dlc2'
09:44:27.04   GAME -- Closing state 'dlc2'
09:44:27.04   GAME -- Setting campaign state to 'dlc3'
09:44:27.04   GAME -- Closing state 'dlc3'
09:44:27.04   Activating screen: OnlineGameSetup
09:44:27.04   Activating screen: RelicOnlineTabs
09:44:27.04   AutomatchInternal::OnHostComplete - Completed Host with success=1
09:44:27.04   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
09:44:27.04   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
09:44:27.05   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:27.05   Net::Session::SetVisible - session is set to VISIBLE.
09:44:27.05   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:27.13   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:27.14   GAME -- Setting campaign state to 'dlc1'
09:44:27.14   GAME -- Closing state 'dlc1'
09:44:27.14   GAME -- Setting campaign state to 'dlc2'
09:44:27.14   GAME -- Closing state 'dlc2'
09:44:27.14   GAME -- Setting campaign state to 'dlc3'
09:44:27.15   GAME -- Closing state 'dlc3'
09:44:27.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:28.85   Activating screen: RaceSelectionPopup
09:44:29.64   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:29.64   Net::Session::SetVisible - session is set to VISIBLE.
09:44:29.64   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:29.65   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:29.68   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:30.98   Activating screen: DynamicPopupMenu
09:44:31.67   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:31.67   Net::Session::SetVisible - session is set to VISIBLE.
09:44:31.67   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:31.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:31.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:45.04   Activating screen: RaceSelectionPopup
09:44:45.80   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:45.80   Net::Session::SetVisible - session is set to VISIBLE.
09:44:45.80   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:45.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:45.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:46.47   Activating screen: DynamicPopupMenu
09:44:47.09   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:47.09   Net::Session::SetVisible - session is set to INVISIBLE.
09:44:47.09   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:47.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:47.13   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:47.60   Activating screen: RaceSelectionPopup
09:44:48.24   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:48.24   Net::Session::SetVisible - session is set to INVISIBLE.
09:44:48.24   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:48.26   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:48.29   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:48.93   Activating screen: DynamicPopupMenu
09:44:49.55   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:49.55   Net::Session::SetVisible - session is set to INVISIBLE.
09:44:49.55   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:49.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:49.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:51.78   Activating screen: DynamicPopupMenu
09:44:52.40   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:52.40   Net::Session::SetVisible - session is set to INVISIBLE.
09:44:52.40   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:52.40   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:52.44   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:53.02   Activating screen: DynamicPopupMenu
09:44:54.02   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:54.02   Net::Session::SetVisible - session is set to INVISIBLE.
09:44:54.02   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:54.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:54.07   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:57.38   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:57.38   Net::Session::SetVisible - session is set to INVISIBLE.
09:44:57.38   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:57.40   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:57.43   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:58.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:44:59.81   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:44:59.81   Net::Session::SetVisible - session is set to INVISIBLE.
09:44:59.81   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:44:59.83   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:44:59.87   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:45:04.95   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:45:08.35   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:45:08.35   Net::Session::SetVisible - session is set to INVISIBLE.
09:45:08.35   GetMaxFrameTimeFromProfile: players=6 expected FPS=30.731407, bars=5, max avg=0.033, sd=0.000, 1 samples =  0.03
09:45:08.46   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:45:08.52   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:45:14.50   GameSetupForm - No win/loss reporting and only a single player, disconnecting
09:45:14.50   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:45:14.50   SetVisible called while !IsConnected
09:45:14.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:45:14.50   GameSetupForm - Starting game
09:45:14.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:45:14.51   PopulateGameInfo - random seed:[1308278714], guid:[{68320138-72d8-4ade-8948-65fa186db8b9}], sync level:[2]
09:45:14.51   Error loading [DATA:levelingCurve.lua]
09:45:14.51   Error loading [DATA:levelingCurve.lua]
09:45:14.51   Error loading [DATA:levelingCurve.lua]
09:45:14.51   Error loading [DATA:levelingCurve.lua]
09:45:14.52   Error loading [DATA:levelingCurve.lua]
09:45:14.52   Error loading [DATA:levelingCurve.lua]
09:45:14.52   MOD - Setting player (0) race to: allies_soviets
09:45:14.52   MOD - Setting player (0) race to: 2
09:45:14.52   MOD - Setting player (1) race to: allies_soviets
09:45:14.52   MOD - Setting player (1) race to: 2
09:45:14.52   MOD - Setting player (2) race to: allies_soviets
09:45:14.52   MOD - Setting player (2) race to: 2
09:45:14.52   MOD - Setting player (3) race to: axis
09:45:14.52   MOD - Setting player (3) race to: 3
09:45:14.52   MOD - Setting player (4) race to: axis
09:45:14.52   MOD - Setting player (4) race to: 3
09:45:14.52   MOD - Setting player (5) race to: axis
09:45:14.52   MOD - Setting player (5) race to: 3
09:45:14.52   Activating screen: MessageBoxPopup
09:45:14.52   Session is marking the local peer PeerID 1 for death
09:45:14.52   Session::GetEvent DestroyPeer success Peer 1 removed
09:45:14.52   Session::DestroyPeer - deallocating peer 1
09:45:14.52   Session - Requested Disconnect for connectionID 2
09:45:14.52   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:45:14.52   Session - Requested Disconnect for connectionID 3
09:45:14.52   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:45:14.52   AdvertisementInternal::Process - EVENT_DESTROYPEER
09:45:14.52   Destroyed Matchinfo
09:45:14.53   APP -- Game Start
09:45:14.53   Sent message game CompanyOfHeroes allowtraffic
09:45:14.53   GAME -- Setting campaign state to 'dlc1'
09:45:14.53   GAME -- Closing state 'dlc1'
09:45:14.53   GAME -- Setting campaign state to 'dlc2'
09:45:14.53   GAME -- Closing state 'dlc2'
09:45:14.53   GAME -- Setting campaign state to 'dlc3'
09:45:14.53   GAME -- Closing state 'dlc3'
09:45:14.53   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:45:14.54   GAME -- Ending FE
09:45:14.54   UIFrontEnd - Unloading Front End
09:45:14.55   SOUND -- Shutting down ...
09:45:14.64   SOUND -- Shutdown completed!
09:45:14.66
09:45:14.66   GAME -- *** Beginning mission 6p_seelow (1 Humans, 5 Computers) ***
09:45:14.66
09:45:15.33   GAME -- Recording game
09:45:15.39   Activating screen: GameLoadScreen
09:45:15.39   ReportGameStartStats - no connection to server unable to report
09:45:15.39   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:45:15.39   PeerRemoveAll - flushing local session peer data
09:45:15.39   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:45:15.39   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
09:45:15.89   THREAD: Hyper-Threading Technology Processors are not detected.
09:45:15.99   SOUND -- Initializing ...
09:45:16.71   SOUND -- Initialization completed!
09:45:16.73   PHYSICS: detected processor(s) capable of handling 4 threads.
09:45:16.73   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\6p_seelow'
09:45:16.74   MOD -- Using Mod 'Eastern_Front'
09:45:16.75   Unable to load/parse precache file [DATA:scenarios\mp\6p_seelow_precache.lua]
09:45:16.88   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
09:45:16.89   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
09:45:20.37   GameObjLoader - upgrading load_count from 0 to 1160
09:45:23.24   GameObjLoader - upgrading load_count from 1160 to 1902
09:45:23.32   PHYSICS -- Created node factory 'HVOK'
09:45:23.32   PHYSICS -- Created node factory 'DMMY'
09:45:35.10   GameObjLoader - upgrading load_count from 1561 to 4371
09:45:39.97   GameObjLoader 041cbdc0 - resetting counters
09:45:39.97   GameObjLoader 041cbdc0 - LOAD_DONE
09:45:39.97   GAME - SessionSetup
09:45:40.21   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
09:45:40.21   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 2048 x 2048
09:45:40.21   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
09:45:45.27   GAME - CreateGEWorld in 5300 ms
09:45:45.28   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:45:45.68   GAME - SessionSetup finished in 5710 ms
09:45:45.69   GAME - WaterReflectionManagerSetup
09:45:45.69   GAME - WaterReflectionManagerSetup finished in 0 ms
09:45:46.22   MessageInternal::CreateChannel: Created channel 474d4343
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x06805078
[Cope FactionFix] - patched @0x6dc15491
[Cope FactionFix] - hooked @0x6dc15492
[Cope FactionFix] - patched @0x6dc14a07
[Cope FactionFix] - hooked @0x6dc14a07
[Cope FactionFix] - Hook installed
09:45:46.43   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
09:45:46.43   didn't add a border to sector 6!!!
09:45:46.43   didn't add a border to sector 11!!!
09:45:46.43   Sector 21 is a single cell, it can't have its border traced
09:45:46.44   didn't add a border to sector 23!!!
09:45:46.44   didn't add a border to sector 24!!!
09:45:47.00   MOD -- Player  (unused player) (frame 0) (KillPlayer)
09:45:47.00   MOD -- Player  (unused player) (frame 0) (KillPlayer)
09:45:48.72   MessageInternal::CreateChannel: Created channel 4d4f444d
09:45:49.21   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
09:45:49.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:45:49.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:45:49.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:45:49.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:45:49.65   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:45:50.20   SPEECHMANAGER -- Loaded in 0.504915 seconds
09:45:51.82   GameObjLoader - upgrading load_count from 0 to 442
09:45:53.25   GameObjLoader 041cbf20 - resetting counters
09:45:53.25   GameObjLoader 041cbf20 - LOAD_DONE
09:45:55.31   PreloadResources took 2000ms.
09:45:55.34   GAME -- Loading completed (40 seconds)
09:45:55.34   SIM -- Setting SyncErrorChecking level to None
09:45:59.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:47:00.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:48:01.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:49:02.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:50:03.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:51:04.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:52:05.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:53:06.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:54:07.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:55:08.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
09:56:09.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:56:33.47   Activating screen: GameScreen
09:56:33.47   Activating screen: Decorators
09:56:33.47   Activating screen: Taskbar
09:56:33.47   Activating screen: SubtitleScreen
09:56:33.47   Activating screen: TextOverlayScreen
09:56:33.61   PerformanceRecorder::StartRecording for game size 6
09:56:33.61   GAME -- Starting mission...
09:56:34.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:56:34.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:56:34.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:56:34.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:56:34.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:56:39.18   Warning: non auto-match upgrade not found in AE, tuning
09:56:48.28   Activating screen: pause_menu
09:56:48.29   GAME -- SimulationController::Pause 0
09:56:49.75   Activating screen: pause_options
09:56:57.34   GAME -- SimulationController::Pause 1
09:57:02.83   Activating screen: Command_Tree
09:57:05.28   Activating screen: Command_Branch
09:57:10.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:57:11.39   Activating screen: Command_Branch
09:57:19.11   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
09:58:11.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:58:50.64   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
09:58:55.51   Warning: binding repeat_1(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12]
09:59:12.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:00:13.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:01:14.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:01:34.90   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:01:34.90   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:10.16   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:13.76   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:15.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:02:16.27   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:18.76   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:18.88   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:24.26   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:54.02   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:54.03   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
10:02:54.03   Muting spew of bind updater.  Fix art and re-test.
10:03:16.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:04:17.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:04:33.49   Unabled to do upgrade, CANPRODUCE_NoResources
10:05:18.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
10:06:19.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:07:20.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:07:43.52   Activating screen: Command_Branch
10:07:45.24   Activating screen: NewObjective
10:08:21.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
10:09:22.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:10:22.74   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:10:23.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:11:00.40   FXShader::SetVariable( "tex0", T ) uses unknown variable.
10:11:24.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:12:25.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:12:47.66   Was already stealing a skeleton when told to steal another [mortar_target].
10:13:00.78   Activating screen: Command_Branch
10:13:26.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:14:27.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:15:28.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:16:16.84   Activating screen: Command_Branch
10:16:19.84   Activating screen: Command_Branch
10:16:29.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:17:30.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.6/0.1, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:18:31.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:19:32.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:19:38.82   Activating screen: Command_Branch
10:19:41.00   Activating screen: NewObjective
10:19:52.34   Unabled to do upgrade, CANPRODUCE_NoResources
10:20:33.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.6/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:21:22.68   Activating screen: pause_menu
10:21:22.74   GAME -- SimulationController::Pause 0
10:21:23.69   Activating screen: prompt_generic
10:21:24.39   MOD -- Player NGOCQUANG-PC (network abort) (frame 11809) (KillPlayer)
10:21:24.39   GameApp::ReportStats
10:21:24.39   ReportStats - untracked game, no need to report match 4294967295:4294967295
10:21:24.39   ReportSimStats - nothing to report, no connection to the server
10:21:24.39   ReportStats - ReportSimStats failed
10:21:24.39   GameApp::Quit( exitValue = 0 )
10:21:24.42   GAME -- SimulationController::Pause 1
10:21:24.42   Activating screen: AppRestartingForm
10:21:24.42   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
10:21:24.42   Widget attempting to remove a non-existance listener. Widget:bkg_COH
10:21:24.42   Widget attempting to remove a non-existance listener. Widget:bkg_CXP1
10:21:24.42   Widget attempting to remove a non-existance listener. Widget:bkg_CXP2
10:21:24.42   Widget attempting to remove a non-existance listener. Widget:bkg_COHCXP1
10:21:24.42   Widget attempting to remove a non-existance listener. Widget:bkg_ToV
10:21:24.43   GameApp::ShutFrontEnd
10:21:24.43   GameObj::ShutdownGameObj
10:21:24.43   GAME -- Ending mission (Game over)
10:21:24.58   GameObjLoader 041cbf20 - Unload
10:21:24.58   GameObjLoader 041cbf20 - resetting counters
10:21:24.65   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
10:21:24.65   MOD -- Game Over at frame 11809
10:21:24.89   GameObjLoader 041cbdc0 - Unload
10:21:24.89   GameObjLoader 041cbdc0 - resetting counters
10:21:25.02   SOUND -- Shutting down ...
10:21:25.16   SOUND -- Shutdown completed!
10:21:25.17   MessageInternal::DestroyChannel: Destroyed channel 474d4343
10:21:25.17   ~FEAppListener - Flushing queued online notifications
10:21:25.75   DLLDriverLinker -- 2 DLL drivers found.
10:21:25.75   ActionDatabase : [2344] global actions, [145] dummy actions.
10:21:25.75   NetworkManager::Destroy - destroying network manager
10:21:25.75   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
10:21:25.75   MessageInternal::DestroyChannel: Destroyed channel 50525459
10:21:25.75   PartyInternal: Fade to black
10:21:25.75   AutomatchInternal: Fade to black
10:21:25.75   PeerRemoveAll - flushing local session peer data
10:21:25.75   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
10:21:25.75   MessageInternal::DestroyChannel: Destroyed channel 47535450
10:21:25.75   Session - Requested Disconnect for connectionID 1
10:21:25.75   SessionManager::UnregisterSession - Unregistering session 07982e40
10:21:25.75   SessionManager::~SessionManager - uninitializing
10:21:25.77   Net::ThreadFunction - Returning from the network thread function...
10:21:25.78   Transport::~Transport - shutting down transport
10:21:25.78   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
10:21:25.80   Transport::~Connection - closing WINaddr:127.0.0.1:6112;,WINaddr:127.0.0.1:6112;
10:21:25.80   Transport::~Connection - closing WINaddr:5.3.208.164:6112;,WINaddr:5.3.208.164:6112;
10:21:25.81   Wrote 269 bytes to network datastore login_cache.bin
10:21:25.81   Wrote 52 bytes to network datastore global_cache.bin
10:21:25.81   Wrote 28 bytes to network datastore ping_cache.bin
10:21:25.81   Datastore -- uninitialize complete
10:21:25.81   QuazalInitializer - static uninit of Quazal library
10:21:25.81   QuazalInitializer - unhooking memory 0 currently allocated, 228 allocations, total of 22156 bytes
