-- Log file for all dbTracef messages -- 09:28:59.95 NetworkManager::Create - creating network manager 09:28:59.95 Read 404 bytes from network datastore login_cache.bin 09:28:59.95 Read 52 bytes from network datastore global_cache.bin 09:28:59.95 Read 28 bytes from network datastore ping_cache.bin 09:28:59.95 QuazalInitializer - static initializing Quazal library 09:28:59.95 PingCache - populating cache with 0 pings 09:28:59.95 RemoteDLManager - FATAL: failed to spawn DownloadManager process 09:28:59.95 Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header 09:28:59.96 WinTransport - CreateSocket exclusive broadcast socket was available. 09:28:59.96 WinTransport - CreateSocket listening for broadcasts on default port 09:28:59.96 WinTransport - Host Name: my-comp, aliases: , type=AF_INET, len=4 09:28:59.96 WinTransport - Host IP Address #0: [IP address redacted] 09:28:59.96 WinTransport - Interface #0: ip:[IP address redacted], broadcast:[IP address redacted], flags=IFF_UP IFF_BROADCAST IFF_POINTTOPOINT IFF_MULTICAST 09:28:59.96 WinTransport - Interface #1: ip:[IP address redacted], broadcast:[IP address redacted], flags=IFF_UP IFF_BROADCAST IFF_LOOPBACK IFF_MULTICAST 09:28:59.96 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:28:59.96 WinTransport - Quazal address string = udp:/address=[IP address redacted];port=6112 09:28:59.96 SessionManager - Peer Header Size = 16 bytes 09:28:59.96 SessionManager - Game Data overhead = 7 bytes 09:28:59.96 SessionManager - Proxy overhead = 7 bytes 09:28:59.96 MessageInternal::CreateChannel: Created channel 47535450 09:28:59.96 Session::Initialize - info, initializing session object, using threads. 09:28:59.96 SessionManager::RegisterSession - Registering new session 047e3520 09:28:59.96 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:28:59.96 AutomatchInternal: Instantiating 09:28:59.96 PartyInternal: Instantiating 09:28:59.96 MessageInternal::CreateChannel: Created channel 50525459 09:28:59.96 MessageInternal::CreateChannel: Created channel 51434b4d 09:28:59.96 Net::ThreadFunction - Entering network thread function... 09:28:59.96 Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED]. 09:28:59.96 MessageInternal::CreateChannel: Created channel 534d5347 09:28:59.96 MessageInternal::CreateChannel: Created channel 474d4343 09:28:59.96 MessageInternal::CreateChannel: Created channel 474f424a 09:28:59.96 MessageInternal::CreateChannel: Created channel 4d4f444d 09:28:59.96 MessageInternal::CreateChannel: Created channel 53594e43 09:28:59.96 MessageInternal::DestroyChannel: Destroyed channel 534d5347 09:28:59.96 MessageInternal::DestroyChannel: Destroyed channel 474d4343 09:28:59.96 MessageInternal::DestroyChannel: Destroyed channel 474f424a 09:28:59.96 MessageInternal::DestroyChannel: Destroyed channel 4d4f444d 09:28:59.96 MessageInternal::DestroyChannel: Destroyed channel 53594e43 09:28:59.96 GAME -- Available memory: 2047MB Physical RAM, 3346MB Pagefile, 2047 Virtual Address Space 09:29:05.48 DLLDriverLinker -- Adding driver 'spDx9.dll'. 09:29:05.48 DLLDriverLinker -- 1 DLL drivers found. 09:29:06.81 DLLDriverLinker -- 1 DLL drivers found. 09:29:07.03 SPOOGE - Driver[DirectX9 rendering device] version[4,36] 09:29:07.03 GAME -- Resolution set to 1024x768 (windowed). 09:29:07.04 SPDx9 -- Driver Name = nv4_disp.dll Desc = NVIDIA GeForce 7600 GS 09:29:07.04 SPDx9 -- Driver Vendor = 0x10DE Device = 0x0392 SubSys = 0x04131462 Rev = 0x00A1 09:29:07.04 SPDx9 -- Driver Version Product = 0x0006 Version = 0x000E SubVersion = 0x00 Build = 266.58 09:29:07.04 SPDx9 -- Driver GUID = {D7B71E3E-40D2-11CF-D06D-1F2400C2CB35} 09:29:07.04 SPDx9 -- 728MB available Texture Memory 09:29:07.06 ShaderDatabase: using shader profile [ps15] 09:29:07.71 FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua' 09:29:07.93 GameObjLoader 0738b750 - resetting counters 09:29:07.93 GameObjLoader 0738b750 - Created loader 09:29:07.93 GameObjLoader 07365208 - resetting counters 09:29:07.93 GameObjLoader 07365208 - Created loader 09:29:08.20 GAME -- Beginning FE 09:29:08.20 UIFrontEnd - Loading Front End 09:29:08.20 THREAD: Hyper-Threading Technology Processors are not detected. 09:29:08.28 SOUND -- Initializing ... 09:29:08.39 INNIMapDCA Key not found: sp_speechducker::time 09:29:09.29 SOUND -- Initialization completed! 09:29:09.29 UIFrontEnd - Initializing Forms 09:29:12.01 CampaignFilter::BindFilterSpecificWidgets() 09:29:12.14 Activating screen: AppLoadingForm 09:29:12.14 SetupProductLoadingArt - choosing bgArt = 4 (gold=0) 09:29:13.17 GAME -- Loaded campaign 'Высадка в Нормандии' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh] 09:29:13.17 GAME -- Loaded campaign 'Освобождение Кан' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1] 09:29:13.17 GAME -- Loaded campaign 'Операция "Огород"' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2] 09:29:13.17 GAME -- Loaded campaign 'Ущелье Фалаис' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3] 09:29:13.17 GAME -- Loaded campaign 'Дамба' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2] 09:29:13.17 GAME -- Loaded campaign '"Сердце Тигра"' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1] 09:29:13.60 GAME -- Using player profile MY-COMP 09:29:13.78 Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase. 09:29:13.93 Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase. 09:29:14.98 QuazalLoginService - *** Connecting to server: localhost:30260 09:29:14.98 RendezvousManager: CreateSession - starting profile=Guest login 09:29:30.00 GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure. 09:29:30.00 RendezvousManager - unable to connect to the server as guest 09:29:30.00 OnConnect: connect failure 09:29:30.00 RendezvousManager::Shutdown - deleting instance 09:29:30.00 RendezvousManager - terminating all server calls in progress 09:29:30.00 CallManager - terminating all server calls in progress (1 in progress) 09:29:30.00 RendezvousManager - destroying chat handler 09:29:30.00 ~RendezvousManager - m_state = 7, no need for server disconnect 09:29:30.03 OnConnect: this wasnt a reconnect, no need for autologin 09:29:30.03 SetupProductLoadingArt - choosing bgArt = 4 (gold=0) 09:29:30.03 CRC & Version Info : 0000025a:602bf1ff:ec3c9e0d eastern_front:602:factionfix.dll 1 09:29:30.03 Activating screen: FEMovie 09:29:30.03 Activating screen: OnlineWidget 09:29:30.03 Activating screen: RelicOnlineLogin 09:29:30.09 SetupProductLoadingArt - choosing bgArt = 4 (gold=0) 09:29:30.09 You have a valid version of the game. 09:29:30.09 AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now 09:29:30.09 installed_products = ( CXP1 DLC1 DLC2 DLC3 COH ) 09:29:30.09 OnLogin: no previous login, auto selecting profile not required 09:29:30.09 Activating screen: MessageBoxPopup 09:29:30.09 Activating screen: MessageBoxPopup 09:29:30.09 ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1 09:29:31.60 Beginning media verification... 09:29:31.60 Validator type : validators\rs\rs.dll 09:29:31.62 THREAD: Hyper-Threading Technology Processors are not detected. 09:29:31.62 XTHREAD: Detected 1 core(s) with 1 hardware thread(s) 09:29:31.62 XTHREAD: Main thread now used as XThread 0 09:29:31.62 XTHREAD: Spawned thread on processor 1 09:29:31.62 Activating screen: MessageBoxPopup 09:29:55.07 Activating screen: FE_mm_01 09:29:55.07 GAME -- Setting campaign state to 'coh' 09:29:55.07 GAME -- Closing state 'coh' 09:29:55.09 GAME -- Setting campaign state to 'cxp2' 09:29:55.09 GAME -- Closing state 'cxp2' 09:29:55.09 GAME -- Setting campaign state to 'cxp1' 09:29:55.09 GAME -- Closing state 'cxp1' 09:29:55.09 GAME -- Setting campaign state to 'dlc1' 09:29:55.09 GAME -- Closing state 'dlc1' 09:29:55.09 GAME -- Setting campaign state to 'dlc2' 09:29:55.09 GAME -- Closing state 'dlc2' 09:29:55.10 GAME -- Setting campaign state to 'dlc3' 09:29:55.10 GAME -- Closing state 'dlc3' 09:29:56.90 Activating screen: MessageBoxPopup 09:29:56.90 Created Matchinfo 09:29:56.90 Session::Reset with reason 999 and AdvertisementInternal::ResetSession() 09:29:56.90 starting LAN hosting 09:29:56.93 OnJoinAdvertisementSuccess - joined online match, server leave notification required 09:29:56.93 starting local hosting 09:29:56.93 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:29:56.93 Allocated route ID=0 for PeerID 1 at WINaddr:[IP address redacted]:6112; 09:29:56.93 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:29:56.93 Session::Host sid = E973790E3C833A6B, hostURL = , local addresses = WINaddr:[IP address redacted]:6112; 09:29:56.93 ValidateCustomData: called with 187 bytes of custom data 09:29:56.93 Host accepted Peer 1 into the match at address list=WINaddr:[IP address redacted]:6112;, routes=WINaddr:[IP address redacted]:6112; 09:29:56.93 AdvertisementInternal::Process - EVENT_NEWPEER 09:29:56.93 Session::GetState - info, session's state changed to [2:STATE_CONNECTING]. 09:29:56.96 Session::GetState - info, session's state changed to [3:STATE_CONNECTED]. 09:29:56.96 hosting - Session is connected 09:29:56.96 Net::Session::SetVisible - session is set to VISIBLE. 09:29:56.98 hosting completed successfully 09:29:56.98 HostAsync - completed with HostResult = 0 09:29:56.98 UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01 09:29:56.98 Activating screen: OnlineGameSetup 09:29:56.98 MessageInternal::CreateChannel: Created channel 534d5347 09:29:56.98 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:29:56.98 MatchInternal::SetMatchType - new type 14 - updating server 09:29:57.00 local host PeerID 1 CONN ack= 0 ( 0ms~0) unack= 0, retry= 0, highwaterOOS=0 @WINaddr:[IP address redacted]:6112; (ping=0ms) 100.00%, pending=0, dead=0 09:29:57.00 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:29:57.01 SetVisible called while !IsConnected 09:29:57.01 GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples = 09:29:57.01 Activating screen: RelicOnlineChat 09:29:57.01 Activating screen: RelicOnlineNewsScreen 09:29:57.01 Activating screen: RelicOnlineStatsScreen 09:29:57.01 Activating screen: Achievements 09:29:57.03 GAME -- Setting campaign state to 'dlc1' 09:29:57.03 GAME -- Closing state 'dlc1' 09:29:57.03 GAME -- Setting campaign state to 'coh' 09:29:57.03 GAME -- Closing state 'coh' 09:29:57.03 GAME -- Setting campaign state to 'cxp2' 09:29:57.03 GAME -- Closing state 'cxp2' 09:29:57.04 GAME -- Setting campaign state to 'cxp1' 09:29:57.04 GAME -- Closing state 'cxp1' 09:29:57.04 GAME -- Setting campaign state to 'dlc1' 09:29:57.04 GAME -- Closing state 'dlc1' 09:29:57.04 GAME -- Setting campaign state to 'dlc2' 09:29:57.04 GAME -- Closing state 'dlc2' 09:29:57.04 GAME -- Setting campaign state to 'dlc3' 09:29:57.04 GAME -- Closing state 'dlc3' 09:29:57.06 GAME -- Setting campaign state to 'dlc1' 09:29:57.06 GAME -- Closing state 'dlc1' 09:29:57.07 Activating screen: GameHistory 09:29:57.07 GAME -- Setting campaign state to 'coh' 09:29:57.07 GAME -- Closing state 'coh' 09:29:57.07 GAME -- Setting campaign state to 'cxp2' 09:29:57.07 GAME -- Closing state 'cxp2' 09:29:57.09 GAME -- Setting campaign state to 'cxp1' 09:29:57.09 GAME -- Closing state 'cxp1' 09:29:57.09 GAME -- Setting campaign state to 'dlc1' 09:29:57.09 GAME -- Closing state 'dlc1' 09:29:57.09 GAME -- Setting campaign state to 'dlc2' 09:29:57.09 GAME -- Closing state 'dlc2' 09:29:57.10 GAME -- Setting campaign state to 'dlc3' 09:29:57.10 GAME -- Closing state 'dlc3' 09:29:57.10 Activating screen: OnlineGameSetup 09:29:57.10 Activating screen: RelicOnlineTabs 09:29:57.10 AutomatchInternal::OnHostComplete - Completed Host with success=1 09:29:57.10 AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring 09:29:57.10 QuickMatchInternal::OnHostComplete - Quickmatch not in host state. 09:29:57.10 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:29:57.10 Net::Session::SetVisible - session is set to INVISIBLE. 09:29:57.12 GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples = 09:29:57.15 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:57.18 GAME -- Setting campaign state to 'coh' 09:29:57.18 GAME -- Closing state 'coh' 09:29:57.18 GAME -- Setting campaign state to 'cxp2' 09:29:57.18 GAME -- Closing state 'cxp2' 09:29:57.18 GAME -- Setting campaign state to 'cxp1' 09:29:57.18 GAME -- Closing state 'cxp1' 09:29:57.18 GAME -- Setting campaign state to 'dlc1' 09:29:57.18 GAME -- Closing state 'dlc1' 09:29:57.20 GAME -- Setting campaign state to 'dlc2' 09:29:57.20 GAME -- Closing state 'dlc2' 09:29:57.20 GAME -- Setting campaign state to 'dlc3' 09:29:57.20 GAME -- Closing state 'dlc3' 09:29:57.28 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:58.25 Activating screen: GameHistory 09:29:58.25 Activating screen: RelicOnlineTabs 09:29:59.45 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:59.45 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:59.45 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:59.45 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:59.46 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:59.46 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:59.46 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:29:59.46 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:30:00.00 Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 09:30:02.71 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:30:02.71 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:30:02.71 Activating screen: MessageBoxPopup 09:30:02.71 Session is marking the local peer PeerID 1 for death 09:30:02.71 Session::GetEvent DestroyPeer success Peer 1 removed 09:30:02.71 Session::DestroyPeer - deallocating peer 1 09:30:02.71 Session - Requested Disconnect for connectionID 2 09:30:02.71 Deallocated route ID=3 for PeerID 1 at WINaddr:[IP address redacted]:6112; 09:30:02.71 Session - Requested Disconnect for connectionID 3 09:30:02.71 Closed route 3<>3 for PeerID 1 at WINaddr:[IP address redacted]:6112; 09:30:02.71 AdvertisementInternal::Process - EVENT_DESTROYPEER 09:30:02.71 Destroyed Matchinfo 09:30:02.73 Transport - Largest sent is now 8 09:30:02.73 APP -- Game Load 09:30:02.73 GameApp::TransitionGameLoad 09:30:02.73 GAME -- Setting campaign state to 'coh' 09:30:02.73 GAME -- Closing state 'coh' 09:30:02.73 GAME -- Setting campaign state to 'cxp2' 09:30:02.73 GAME -- Closing state 'cxp2' 09:30:02.75 Transport - Largest received is now 8 09:30:02.75 GAME -- Setting campaign state to 'cxp1' 09:30:02.75 GAME -- Closing state 'cxp1' 09:30:02.75 GAME -- Setting campaign state to 'dlc1' 09:30:02.75 GAME -- Closing state 'dlc1' 09:30:02.75 GAME -- Setting campaign state to 'dlc2' 09:30:02.75 GAME -- Closing state 'dlc2' 09:30:02.76 GAME -- Setting campaign state to 'dlc3' 09:30:02.76 GAME -- Closing state 'dlc3' 09:30:02.76 MessageInternal::DestroyChannel: Destroyed channel 534d5347 09:30:02.78 GAME -- Ending FE 09:30:02.78 UIFrontEnd - Unloading Front End 09:30:02.79 SOUND -- Shutting down ... 09:30:02.90 SOUND -- Shutdown completed! 09:30:02.92 GAME -- Beginning FE 09:30:02.92 UIFrontEnd - Loading Front End 09:30:02.92 THREAD: Hyper-Threading Technology Processors are not detected. 09:30:02.96 SOUND -- Initializing ... 09:30:04.15 SOUND -- Initialization completed! 09:30:04.15 UIFrontEnd - Initializing Forms 09:30:07.18 CampaignFilter::BindFilterSpecificWidgets() 09:30:07.32 Turning off auto-selection of profiles, we already have a profile selected. 09:30:07.32 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:30:07.32 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:30:07.32 MOD - Setting player (0) race to: allies_soviets 09:30:07.32 MOD - Setting player (0) race to: 2 09:30:07.32 MOD - Setting player (1) race to: allies_soviets 09:30:07.32 MOD - Setting player (1) race to: 2 09:30:07.32 MOD - Setting player (2) race to: allies_soviets 09:30:07.32 MOD - Setting player (2) race to: 2 09:30:07.32 MOD - Setting player (3) race to: allies_soviets 09:30:07.32 MOD - Setting player (3) race to: 2 09:30:07.32 MOD - Setting player (4) race to: axis 09:30:07.32 MOD - Setting player (4) race to: 3 09:30:07.32 MOD - Setting player (5) race to: axis_panzer_elite 09:30:07.32 MOD - Setting player (5) race to: 4 09:30:07.32 MOD - Setting player (6) race to: axis 09:30:07.32 MOD - Setting player (6) race to: 3 09:30:07.32 MOD - Setting player (7) race to: axis_panzer_elite 09:30:07.32 MOD - Setting player (7) race to: 4 09:30:07.32 ReportGameStartStats - no connection to server unable to report 09:30:07.32 Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED]. 09:30:07.32 PeerRemoveAll - flushing local session peer data 09:30:07.32 Session::Reset with reason 999 and MatchInternal::PeerRemoveAll 09:30:07.32 APP -- Game Start 09:30:07.32 GAME -- Ending FE 09:30:07.32 UIFrontEnd - Unloading Front End 09:30:07.34 SOUND -- Shutting down ... 09:30:07.46 SOUND -- Shutdown completed! 09:30:07.46 09:30:07.46 GAME -- *** Beginning mission 8p_rostov (1 Humans, 7 Computers) *** 09:30:07.46 09:30:07.46 GAME -- Recording game 09:30:07.57 Activating screen: GameLoadScreen 09:30:07.57 ReportGameStartStats - no connection to server unable to report 09:30:07.90 THREAD: Hyper-Threading Technology Processors are not detected. 09:30:07.95 SOUND -- Initializing ... 09:30:09.15 SOUND -- Initialization completed! 09:30:09.17 PHYSICS: detected processor(s) capable of handling 1 threads. 09:30:09.18 MOD -- Locating MOD for scenario 'DATA:scenarios\mp\8p_rostov' 09:30:09.18 MOD -- Using Mod 'Eastern_Front' 09:30:09.18 Unable to load/parse precache file [DATA:scenarios\mp\8p_rostov_precache.lua] 09:30:09.34 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'. Expensive operation 09:30:09.34 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'. Expensive operation 09:30:15.85 GameObjLoader - upgrading load_count from 0 to 1219 09:30:23.81 GameObjLoader - upgrading load_count from 1219 to 1982 09:30:24.15 PHYSICS -- Created node factory 'HVOK' 09:30:24.15 PHYSICS -- Created node factory 'DMMY' 09:30:45.53 GameObjLoader - upgrading load_count from 7 to 4606 09:30:46.29 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'. Expensive operation 09:30:56.48 GameObjLoader 0738b750 - resetting counters 09:30:56.48 GameObjLoader 0738b750 - LOAD_DONE