-- Log file for all dbTracef messages -- 09:54:52.17 NetworkManager::Create - creating network manager 09:54:52.18 Read 922 bytes from network datastore login_cache.bin 09:54:52.18 Read 114210 bytes from network datastore global_cache.bin 09:54:52.19 Read 133606 bytes from network datastore ping_cache.bin 09:54:52.19 QuazalInitializer - static initializing Quazal library 09:54:52.20 PingCache - populating cache with 796 pings 09:54:52.32 Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header 09:54:52.32 WinTransport - CreateSocket exclusive broadcast socket was available. 09:54:52.32 WinTransport - CreateSocket listening for broadcasts on default port 09:54:52.60 WinTransport - Host Name: Martin-PC, aliases: , type=AF_INET, len=4 09:54:52.60 WinTransport - Host IP Address #0: [IP address redacted] 09:54:52.60 WinTransport - Interface #0: ip:[IP address redacted], broadcast:[IP address redacted], flags=IFF_UP IFF_BROADCAST IFF_MULTICAST 09:54:52.60 WinTransport - Interface #1: ip:[IP address redacted], broadcast:[IP address redacted], flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST 09:54:52.60 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:54:52.60 WinTransport - Quazal address string = udp:/address=[IP address redacted];port=6112 09:54:52.60 SessionManager - Peer Header Size = 16 bytes 09:54:52.60 SessionManager - Game Data overhead = 7 bytes 09:54:52.60 SessionManager - Proxy overhead = 7 bytes 09:54:52.60 MessageInternal::CreateChannel: Created channel 47535450 09:54:52.60 Session::Initialize - info, initializing session object, using threads. 09:54:52.60 SessionManager::RegisterSession - Registering new session 07b8ce60 09:54:52.60 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:54:52.60 AutomatchInternal: Instantiating 09:54:52.60 PartyInternal: Instantiating 09:54:52.60 MessageInternal::CreateChannel: Created channel 50525459 09:54:52.60 MessageInternal::CreateChannel: Created channel 51434b4d 09:54:52.61 Net::ThreadFunction - Entering network thread function... 09:54:52.62 Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED]. 09:54:52.63 MessageInternal::CreateChannel: Created channel 534d5347 09:54:52.63 MessageInternal::CreateChannel: Created channel 474d4343 09:54:52.63 MessageInternal::CreateChannel: Created channel 474f424a 09:54:52.63 MessageInternal::CreateChannel: Created channel 4d4f444d 09:54:52.63 MessageInternal::CreateChannel: Created channel 53594e43 09:54:52.63 MessageInternal::DestroyChannel: Destroyed channel 534d5347 09:54:52.63 MessageInternal::DestroyChannel: Destroyed channel 474d4343 09:54:52.63 MessageInternal::DestroyChannel: Destroyed channel 474f424a 09:54:52.63 MessageInternal::DestroyChannel: Destroyed channel 4d4f444d 09:54:52.63 MessageInternal::DestroyChannel: Destroyed channel 53594e43 09:54:52.63 GAME -- Available memory: 6143MB Physical RAM, 6141MB Pagefile, 4095 Virtual Address Space 09:54:52.65 Transport - Largest received is now 19 09:54:52.65 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:54:54.87 DLLDriverLinker -- Adding driver 'spDx10.dll'. 09:54:54.95 DLLDriverLinker -- Adding driver 'spDx9.dll'. 09:54:54.95 DLLDriverLinker -- 2 DLL drivers found. 09:54:55.00 SPDx10 -- Adapter [ATI Radeon HD 4800 Series ]: 1014MB dedicated video memory, 0MB dedicated system memory and 2815MB shared system memory. 09:54:56.52 DLLDriverLinker -- 2 DLL drivers found. 09:54:56.62 SPOOGE - Driver[DirectX10 Rendering Device] version[4,36] 09:54:56.62 GAME -- Resolution set to 1920x1080 (fullscreen). 09:54:56.67 SPDx10 -- Adapter Description = ATI Radeon HD 4800 Series 09:54:56.67 SPDx10 -- Driver Vendor = 0x00001002 Device = 0x00009440 SubSys = 0x22671787 Rev = 0x00000000 09:54:56.67 SPDx10 -- Driver Version Product = 0x0008 Version = 0x0011 SubVersion = 0x00 Build = 10.77 09:54:56.67 SPDx10 -- Driver LUID = 0x00000000-0x0000a53d 09:54:56.67 SPDx10 -- 1014MB dedicated video memory, 0MB dedicated system memory and 2815MB shared system memory available. 09:54:56.69 ShaderDatabase: using shader profile [ps40] 09:54:57.40 SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 1024. 09:54:57.54 SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 1024. 09:54:57.56 FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua' 09:54:58.35 GameObjLoader 074fb4a8 - resetting counters 09:54:58.35 GameObjLoader 074fb4a8 - Created loader 09:54:58.35 GameObjLoader 074fb608 - resetting counters 09:54:58.35 GameObjLoader 074fb608 - Created loader 09:54:59.02 GAME -- Beginning FE 09:54:59.02 Sent message game CompanyOfHeroes started 4556 602 allowtraffic 09:54:59.02 RemoteDLManager - Connection Restored. 09:54:59.02 UIFrontEnd - Loading Front End 09:54:59.02 THREAD: Hyper-Threading Technology Processors are not detected. 09:54:59.15 SOUND -- Initializing ... 09:54:59.23 INNIMapDCA Key not found: sp_speechducker::time 09:54:59.61 SOUND -- Initialization completed! 09:54:59.61 UIFrontEnd - Initializing Forms 09:55:01.11 CampaignFilter::BindFilterSpecificWidgets() 09:55:01.22 Activating screen: MovieScreen 09:55:01.22 Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2000 seedratio 0] 09:55:04.01 Activating screen: AppLoadingForm 09:55:04.01 SetupProductLoadingArt - choosing bgArt = 4 (gold=0) 09:55:05.64 GAME -- Loaded campaign 'Invasion der Normandie' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh] 09:55:05.64 GAME -- Loaded campaign 'Befreiung von Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1] 09:55:05.64 GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2] 09:55:05.65 GAME -- Loaded campaign 'Kessel von Falaise' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3] 09:55:05.66 GAME -- Loaded campaign 'Damm' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2] 09:55:05.66 GAME -- Loaded campaign 'Tigerass' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1] 09:55:06.35 SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 1024. 09:55:06.41 SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 1024. 09:55:06.63 GAME -- Using player profile MARTIN-PC 09:55:07.38 Dx10Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase. 09:55:07.65 Dx10Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase. 09:55:10.10 QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260 09:55:10.10 RendezvousManager: CreateSession - starting profile=Guest login 09:55:11.29 RendezvousManager: Login complete and successfull 09:55:11.30 RendezvousManager initialized 09:55:11.44 Current server German:live version is 602.0, client is 602.0 09:55:11.45 OnConnect: successful connection established, enabling reconnect 09:55:11.45 OnConnect: this wasnt a reconnect, no need for autologin 09:55:11.47 Logging in huetter on controller:0 09:55:11.89 Login completed: ACCOUNT_VALIDATED 09:55:11.89 Found 2 profiles for account huetter 09:55:11.89 Found profile: Huetter 09:55:11.89 Found profile: TheRevoluzer 09:55:11.89 installed_products = ( COH CXP1 DLC1 DLC2 DLC3 ) 09:55:11.89 OnLogin: no previous login, auto selecting profile not required 09:55:11.92 SetupProductLoadingArt - choosing bgArt = 1 (gold=1) 09:55:11.93 CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1 09:55:11.95 Activating screen: FEMovie 09:55:11.95 Activating screen: OnlineWidget 09:55:11.95 Activating screen: RelicOnlineProfileSelect 09:55:12.01 SetupProductLoadingArt - choosing bgArt = 1 (gold=1) 09:55:12.01 Activating screen: RelicOnlineWait 09:55:12.01 RendezvousManager - destroying chat handler 09:55:12.01 RendezvousManager: CreateSession - starting logout profile = 100:Guest 09:55:12.27 RendezvousManager: Logout complete 09:55:12.27 RendezvousManager - terminating all server calls in progress 09:55:12.27 CallManager - terminating all server calls in progress (1 in progress) 09:55:12.27 RendezvousManager: OnCredentialsEvent - starting profile login 09:55:13.40 RendezvousManager: Login complete and successfull 09:55:13.40 RendezvousManager - creating chat handler 09:55:13.41 RendezvousManager::CreateNATTraversalClient - NAT traversal available. 09:55:13.64 QuazalSelectProfileAsync - Got UserID 09:55:13.66 Transport - Largest sent is now 16 09:55:13.79 Transport - Largest received is now 43 09:55:13.80 GetUserStats requested stats for PIDs ( 3385324 ) (best:0, full:1) 09:55:13.92 SelectProfileAsync - RegisterLocalURLs public [udp:/address=[IP address redacted];port=6112;PID=3385324;RVCID=44196327], private [udp:/address=[IP address redacted];port=6112;PID=3385324] 09:55:14.07 QuazalSelectProfileAsync - Got Full Stats 09:55:14.25 GetAutomatchMaps: Got [35] maps 09:55:14.28 PopulateArmyListBox - skipping race 2 09:55:14.28 PopulateArmyListBox - skipping race 0 09:55:14.28 PopulateArmyListBox - skipping race 1 09:55:14.28 PopulateArmyListBox - skipping race 3 09:55:14.28 AutoMatchForm::OnArmySelectionChanged - sending request info 09:55:14.28 GetMaxFrameTimeFromProfile: players=2 expected FPS=22.074789, bars=5, max avg=0.033, sd=0.012, 5 samples = 0.04 0.03 0.05 0.03 0.02 09:55:14.28 AutoMatchForm::OnMatchTypeSelectionChanged - sending team info 09:55:14.28 QuazalSelectProfileAsync - Got Automatch maps 09:55:15.12 QuazalSelectProfileAsync - GetFriends result - CacheState = 1 09:55:15.29 Profile [00000000:0033a7ec] selected on controller#0 09:55:15.29 Activating screen: FEMovie 09:55:15.29 Activating screen: OnlineWidget 09:55:15.29 Activating screen: FE_mm_01 09:55:15.29 Activating screen: RelicOnlineWait 09:55:15.30 GAME -- Setting campaign state to 'coh' 09:55:15.30 GAME -- Closing state 'coh' 09:55:15.31 GAME -- Setting campaign state to 'cxp2' 09:55:15.31 GAME -- Closing state 'cxp2' 09:55:15.32 GAME -- Setting campaign state to 'cxp1' 09:55:15.32 GAME -- Closing state 'cxp1' 09:55:15.32 GAME -- Setting campaign state to 'dlc1' 09:55:15.32 GAME -- Closing state 'dlc1' 09:55:15.32 GAME -- Setting campaign state to 'dlc2' 09:55:15.32 GAME -- Closing state 'dlc2' 09:55:15.32 GAME -- Setting campaign state to 'dlc3' 09:55:15.32 GAME -- Closing state 'dlc3' 09:55:17.22 Activating screen: MessageBoxPopup 09:55:17.22 Created Matchinfo 09:55:17.22 Session::Reset with reason 999 and AdvertisementInternal::ResetSession() 09:55:17.22 starting online hosting 09:55:17.26 OnlineHostAsync: initiating CallCreateMatch 09:55:17.44 OnlineHostAsync: created gid=181960178 09:55:17.45 Transport - Largest sent is now 80 09:55:17.54 RendezvousNotifier - Received Participate ParticipationEvent. 09:55:17.59 Transport - Largest received is now 107 09:55:17.70 OnlineHostAsync - RegisterLocalURLs public [udp:/address=[IP address redacted];port=6112;PID=3385324;RVCID=44196327], private [udp:/address=[IP address redacted];port=6112;PID=3385324] 09:55:17.84 OnlineHostAsync: initiating UpdateSessionURL [gid=181960178, url=udp:/address=[IP address redacted];port=6112;PID=3385324;RVCID=44196327] 09:55:18.02 OnJoinAdvertisementSuccess - joined online match, server leave notification required 09:55:18.02 starting local hosting 09:55:18.02 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:55:18.02 Allocated route ID=0 for PeerID 1 at WINaddr:[IP address redacted]:6112; 09:55:18.02 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 09:55:18.02 Session::Host sid = AD87DF2, hostURL = , local addresses = WINaddr:[IP address redacted]:6112; 09:55:18.02 ValidateCustomData: called with 381 bytes of custom data 09:55:18.02 Host accepted Peer 1 into the match at address list=WINaddr:[IP address redacted]:6112;, routes=WINaddr:[IP address redacted]:6112; 09:55:18.02 AdvertisementInternal::Process - EVENT_NEWPEER 09:55:18.02 Session::GetState - info, session's state changed to [2:STATE_CONNECTING]. 09:55:18.04 Session::GetState - info, session's state changed to [3:STATE_CONNECTED]. 09:55:18.04 hosting - Session is connected 09:55:18.04 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:18.06 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:55:18.06 MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/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:55:18.06 hosting completed successfully 09:55:18.06 HostAsync - completed with HostResult = 0 09:55:18.06 UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01 09:55:18.06 Activating screen: OnlineGameSetup 09:55:18.06 MessageInternal::CreateChannel: Created channel 534d5347 09:55:18.06 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:55:18.06 MatchInternal::SetMatchType - new type 14 - updating server 09:55:18.08 SetVisible called while !IsConnected 09:55:18.08 GetMaxFrameTimeFromProfile: players=6 expected FPS=14.379131, bars=4, max avg=0.054, sd=0.016, 5 samples = 0.05 0.06 0.04 0.08 0.04 09:55:18.09 Activating screen: RelicOnlineChat 09:55:18.09 Activating screen: RelicOnlineNewsScreen 09:55:18.15 Activating screen: RelicOnlineStatsScreen 09:55:18.15 Activating screen: Achievements 09:55:18.15 GAME -- Setting campaign state to 'coh' 09:55:18.15 GAME -- Closing state 'coh' 09:55:18.15 GAME -- Setting campaign state to 'cxp2' 09:55:18.15 GAME -- Closing state 'cxp2' 09:55:18.15 GAME -- Setting campaign state to 'cxp1' 09:55:18.15 GAME -- Closing state 'cxp1' 09:55:18.15 GAME -- Setting campaign state to 'dlc1' 09:55:18.15 GAME -- Closing state 'dlc1' 09:55:18.15 GAME -- Setting campaign state to 'dlc2' 09:55:18.15 GAME -- Closing state 'dlc2' 09:55:18.16 GAME -- Setting campaign state to 'dlc3' 09:55:18.16 GAME -- Closing state 'dlc3' 09:55:18.16 GAME -- Setting campaign state to 'dlc1' 09:55:18.16 GAME -- Closing state 'dlc1' 09:55:18.17 Activating screen: GameHistory 09:55:18.17 GAME -- Setting campaign state to 'coh' 09:55:18.17 GAME -- Closing state 'coh' 09:55:18.17 GAME -- Setting campaign state to 'cxp2' 09:55:18.18 GAME -- Closing state 'cxp2' 09:55:18.18 GAME -- Setting campaign state to 'cxp1' 09:55:18.18 GAME -- Closing state 'cxp1' 09:55:18.18 GAME -- Setting campaign state to 'dlc1' 09:55:18.18 GAME -- Closing state 'dlc1' 09:55:18.18 GAME -- Setting campaign state to 'dlc2' 09:55:18.18 GAME -- Closing state 'dlc2' 09:55:18.18 GAME -- Setting campaign state to 'dlc3' 09:55:18.18 GAME -- Closing state 'dlc3' 09:55:18.19 Activating screen: OnlineGameSetup 09:55:18.19 Activating screen: RelicOnlineTabs 09:55:18.19 AutomatchInternal::OnHostComplete - Completed Host with success=1 09:55:18.19 AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring 09:55:18.19 QuickMatchInternal::OnHostComplete - Quickmatch not in host state. 09:55:18.20 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:55:18.20 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:18.20 GetMaxFrameTimeFromProfile: players=6 expected FPS=14.379131, bars=4, max avg=0.054, sd=0.016, 5 samples = 0.05 0.06 0.04 0.08 0.04 09:55:18.28 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:18.30 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 09:55:18.36 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:19.11 Requesting Relic Downloader soft throttle call [GetNewsAsync] has time 810 09:55:19.11 Sent message game CompanyOfHeroes softthrottle 09:55:19.13 Got dlman msg [ack game CompanyOfHeroes softthrottle] 09:55:19.92 GetUserStats requested stats for PIDs ( 2568107 ) (best:1, full:0) 09:55:19.92 QueryMatches: Got [35] maps, [66] ids, [17] advertisements, startID [1] 09:55:19.92 QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 49 matches 09:55:22.80 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:55:22.80 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:22.80 GetMaxFrameTimeFromProfile: players=2 expected FPS=22.074789, bars=5, max avg=0.033, sd=0.012, 5 samples = 0.04 0.03 0.05 0.03 0.02 09:55:22.87 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:22.88 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 09:55:22.89 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:23.62 QueryMatches: Got [33] maps, [65] ids, [17] advertisements, startID [181959213] 09:55:23.62 QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 32 matches 09:55:24.99 Activating screen: RaceSelectionPopup 09:55:26.10 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:55:26.10 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:26.10 GetMaxFrameTimeFromProfile: players=2 expected FPS=22.074789, bars=5, max avg=0.033, sd=0.012, 5 samples = 0.04 0.03 0.05 0.03 0.02 09:55:26.14 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:26.17 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 09:55:26.19 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:26.84 Activating screen: DynamicPopupMenu 09:55:27.17 Transport - Largest sent is now 81 09:55:27.84 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:55:27.84 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:27.85 GetMaxFrameTimeFromProfile: players=2 expected FPS=22.074789, bars=5, max avg=0.033, sd=0.012, 5 samples = 0.04 0.03 0.05 0.03 0.02 09:55:27.87 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:27.90 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:28.48 QueryMatches: Got [35] maps, [68] ids, [17] advertisements, startID [181959914] 09:55:28.48 QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 18 matches 09:55:29.10 Activating screen: Achievements 09:55:29.10 Activating screen: RelicOnlineTabs 09:55:33.48 QueryMatches: Got [33] maps, [66] ids, [17] advertisements, startID [181960101] 09:55:35.68 Activating screen: OnlineGameSetup 09:55:35.68 Activating screen: RelicOnlineTabs 09:55:38.23 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:55:38.23 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:38.23 GetMaxFrameTimeFromProfile: players=2 expected FPS=22.074789, bars=5, max avg=0.033, sd=0.012, 5 samples = 0.04 0.03 0.05 0.03 0.02 09:55:38.25 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:38.29 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:40.94 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 09:55:40.94 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:40.94 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:40.95 MatchInternal::SetMatchState - state 1 - updating server 09:55:40.95 Net::Session::SetVisible - session is set to INVISIBLE. 09:55:40.95 MatchSetup: Sending start game message! 09:55:40.95 GameSetupForm - Starting game 09:55:40.95 GameInfo::ResetInfo - SyncLevel set to 0 on reset 09:55:40.95 PopulateGameInfo - random seed:[1306655740], guid:[{39045d4c-cd8c-4829-a8aa-a7fc7ec10fbf}], sync level:[0] 09:55:40.95 Error loading [DATA:levelingCurve.lua] 09:55:40.95 Error loading [DATA:levelingCurve.lua] 09:55:40.95 MOD - Setting player (0) race to: allies_soviets 09:55:40.95 MOD - Setting player (0) race to: 2 09:55:40.95 MOD - Setting player (1) race to: axis 09:55:40.95 MOD - Setting player (1) race to: 3 09:55:40.96 OnlineUpdateStateAsync: initiating state change, id = 181960178, state=2 09:55:40.96 APP -- Game Start 09:55:40.96 Sent message game CompanyOfHeroes allowtraffic 09:55:40.97 GAME -- Setting campaign state to 'coh' 09:55:40.97 GAME -- Closing state 'coh' 09:55:40.97 GAME -- Setting campaign state to 'cxp2' 09:55:40.97 GAME -- Closing state 'cxp2' 09:55:40.97 GAME -- Setting campaign state to 'cxp1' 09:55:40.97 GAME -- Closing state 'cxp1' 09:55:40.97 GAME -- Setting campaign state to 'dlc1' 09:55:40.97 GAME -- Closing state 'dlc1' 09:55:40.97 GAME -- Setting campaign state to 'dlc2' 09:55:40.97 GAME -- Closing state 'dlc2' 09:55:40.98 GAME -- Setting campaign state to 'dlc3' 09:55:40.98 GAME -- Closing state 'dlc3' 09:55:40.98 MessageInternal::DestroyChannel: Destroyed channel 534d5347 09:55:41.00 GAME -- Ending FE 09:55:41.00 UIFrontEnd - Unloading Front End 09:55:41.02 SOUND -- Shutting down ... 09:55:41.10 SOUND -- Shutdown completed! 09:55:41.13 09:55:41.13 GAME -- *** Beginning mission 2p_vienna (1 Humans, 1 Computers) *** 09:55:41.13 09:55:41.22 GAME -- Recording game 09:55:41.29 Activating screen: GameLoadScreen 09:55:41.29 Got dlman msg [ack game CompanyOfHeroes allowtraffic] 09:55:41.54 OnlineUpdateStateAsync: updated state for gid=181960178 09:55:41.74 THREAD: Hyper-Threading Technology Processors are not detected. 09:55:41.79 SOUND -- Initializing ... 09:55:42.35 SOUND -- Initialization completed! 09:55:42.38 PHYSICS: detected processor(s) capable of handling 3 threads. 09:55:42.45 MOD -- Locating MOD for scenario 'DATA:scenarios\mp\2p_vienna' 09:55:42.45 MOD -- Using Mod 'Eastern_Front' 09:55:42.46 Unable to load/parse precache file [DATA:scenarios\mp\2p_vienna_precache.lua] 09:55:42.51 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'. Expensive operation 09:55:42.52 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'. Expensive operation 09:55:45.21 GameObjLoader - upgrading load_count from 0 to 1065 09:55:47.48 GameObjLoader - upgrading load_count from 1065 to 1730 09:55:47.54 PHYSICS -- Created node factory 'HVOK' 09:55:47.54 PHYSICS -- Created node factory 'DMMY' 09:55:53.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.3/0.0, #p/sec[s/r] = 0.5/0.6, max unsent 0, version err 0, merge 0 09:56:07.88 GameObjLoader - upgrading load_count from 15 to 3959 09:56:14.83 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'. Expensive operation 09:56:15.24 GameObjLoader 074fb4a8 - resetting counters 09:56:15.24 GameObjLoader 074fb4a8 - LOAD_DONE 09:56:15.24 GAME - SessionSetup 09:56:15.67 CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP. 09:56:15.67 TERRAINTEXTURE -- compositor added RenderTarget [0] of size 2048 x 2048 09:56:15.67 TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024 09:56:19.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:56:19.00 MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/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:56:19.59 GAME - CreateGEWorld in 4350 ms 09:56:19.62 TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed. 09:56:20.08 GAME - SessionSetup finished in 4840 ms 09:56:20.08 GAME - WaterReflectionManagerSetup 09:56:20.08 GAME - WaterReflectionManagerSetup finished in 0 ms 09:56:20.35 MessageInternal::CreateChannel: Created channel 474d4343 [Cope FactionFix] - Trying to hook function [Cope FactionFix] - Got LuaState @0x071b3dc8 [Cope FactionFix] - patched @0x66f65491 [Cope FactionFix] - hooked @0x66f65492 [Cope FactionFix] - patched @0x66f64a07 [Cope FactionFix] - hooked @0x66f64a07 [Cope FactionFix] - Hook installed 09:56:20.58 ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded. 09:56:22.58 MOD -- Player (unused player) (frame 0) (KillPlayer) 09:56:22.58 MOD -- Player (unused player) (frame 0) (KillPlayer) 09:56:22.58 MOD -- Player (unused player) (frame 0) (KillPlayer) 09:56:22.58 MOD -- Player (unused player) (frame 0) (KillPlayer) 09:56:22.58 MOD -- Player (unused player) (frame 0) (KillPlayer) 09:56:22.58 MOD -- Player (unused player) (frame 0) (KillPlayer) 09:56:22.98 MessageInternal::CreateChannel: Created channel 4d4f444d 09:56:23.74 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 09:56:23.74 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 09:56:23.74 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 09:56:23.74 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 09:56:23.75 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 09:56:24.23 SPEECHMANAGER -- Loaded in 0.453451 seconds 09:56:25.57 GameObjLoader - upgrading load_count from 0 to 437 09:56:26.82 GameObjLoader 074fb608 - resetting counters 09:56:26.82 GameObjLoader 074fb608 - LOAD_DONE 09:56:27.22 PreloadResources took 0ms. 09:56:27.31 GAME -- Loading completed (46 seconds) 09:56:27.31 SIM -- Setting SyncErrorChecking level to Low 09:56:29.41 Activating screen: GameScreen 09:56:29.41 Activating screen: Decorators_widescreen 09:56:29.41 Activating screen: Taskbar_widescreen 09:56:29.41 Activating screen: SubtitleScreen 09:56:29.41 Activating screen: TextOverlayScreen 09:56:29.51 PerformanceRecorder::StartRecording for game size 2 09:56:29.51 GAME -- Starting mission... 09:56:30.35 MOD -- Player Computer - Normal set to AI Type: AI Player (frame 1) (CmdAI) 09:56:33.13 Warning: binding repeat_2(Ability: abilities\reenable_capture_ability_engineers) -- ui index '0' out of bounds; range is [1, 12] 09:56:33.16 Warning: binding repeat_5(Ability: abilities\smg_mp40) -- ui index '0' out of bounds; range is [1, 12] 09:56:35.06 Warning: non auto-match upgrade not found in AE, tuning 09:56:37.41 Activating screen: Command_Tree 09:56:38.36 Activating screen: Command_Branch 09:56:52.91 Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background' 09:56:54.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.3/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 09:57:20.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:57:20.00 MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/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:57:48.70 Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12] 09:57:55.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.3/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 09:58:21.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:58:21.00 MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/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:58:39.64 WorldViewSM::ProcessWVEvents - setting pause to 1 09:58:39.64 GAME -- SimulationController::Pause 0 09:58:45.87 WorldViewSM::ProcessWVEvents - setting pause to 0 09:58:45.87 GAME -- SimulationController::Pause 1 09:58:56.01 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.3/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 09:59:14.06 WorldViewSM::ProcessWVEvents - setting pause to 1 09:59:14.06 GAME -- SimulationController::Pause 0 09:59:17.42 WorldViewSM::ProcessWVEvents - setting pause to 0 09:59:17.42 GAME -- SimulationController::Pause 1 09:59:21.75 WorldViewSM::ProcessWVEvents - setting pause to 1 09:59:21.75 GAME -- SimulationController::Pause 0 09:59:22.01 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:59:22.01 MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/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:59:24.86 WorldViewSM::ProcessWVEvents - setting pause to 0 09:59:24.86 GAME -- SimulationController::Pause 1 09:59:25.77 WorldViewSM::ProcessWVEvents - setting pause to 1 09:59:25.77 GAME -- SimulationController::Pause 0 09:59:27.34 WorldViewSM::ProcessWVEvents - setting pause to 0 09:59:27.34 GAME -- SimulationController::Pause 1