-- Log file for all dbTracef messages -- 20:41:11.51 NetworkManager::Create - creating network manager 20:41:11.51 Read 781 bytes from network datastore login_cache.bin 20:41:11.51 Read 114392 bytes from network datastore global_cache.bin 20:41:11.51 Read 127558 bytes from network datastore ping_cache.bin 20:41:11.51 QuazalInitializer - static initializing Quazal library 20:41:11.51 PingCache - populating cache with 454 pings 20:41:11.53 Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header 20:41:11.53 WinTransport - CreateSocket exclusive broadcast socket was available. 20:41:11.53 WinTransport - CreateSocket listening for broadcasts on default port 20:41:11.53 WinTransport - Host Name: Julian-PC, aliases: , type=AF_INET, len=4 20:41:11.53 WinTransport - Host IP Address #0: [IP address redacted] 20:41:11.53 WinTransport - Interface #0: ip:[IP address redacted], broadcast:[IP address redacted], flags=IFF_UP IFF_BROADCAST IFF_MULTICAST 20:41:11.53 WinTransport - Interface #1: ip:[IP address redacted], broadcast:[IP address redacted], flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST 20:41:11.53 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 20:41:11.53 WinTransport - Quazal address string = udp:/address=[IP address redacted];port=6112 20:41:11.53 SessionManager - Peer Header Size = 16 bytes 20:41:11.53 SessionManager - Game Data overhead = 7 bytes 20:41:11.53 SessionManager - Proxy overhead = 7 bytes 20:41:11.53 MessageInternal::CreateChannel: Created channel 47535450 20:41:11.53 Session::Initialize - info, initializing session object, using threads. 20:41:11.53 SessionManager::RegisterSession - Registering new session 0739a680 20:41:11.53 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 20:41:11.53 AutomatchInternal: Instantiating 20:41:11.53 PartyInternal: Instantiating 20:41:11.53 MessageInternal::CreateChannel: Created channel 50525459 20:41:11.53 MessageInternal::CreateChannel: Created channel 51434b4d 20:41:11.53 Net::ThreadFunction - Entering network thread function... 20:41:11.55 Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED]. 20:41:11.55 MessageInternal::CreateChannel: Created channel 534d5347 20:41:11.55 MessageInternal::CreateChannel: Created channel 474d4343 20:41:11.55 MessageInternal::CreateChannel: Created channel 474f424a 20:41:11.55 MessageInternal::CreateChannel: Created channel 4d4f444d 20:41:11.55 MessageInternal::CreateChannel: Created channel 53594e43 20:41:11.55 MessageInternal::DestroyChannel: Destroyed channel 534d5347 20:41:11.55 MessageInternal::DestroyChannel: Destroyed channel 474d4343 20:41:11.55 MessageInternal::DestroyChannel: Destroyed channel 474f424a 20:41:11.55 MessageInternal::DestroyChannel: Destroyed channel 4d4f444d 20:41:11.55 MessageInternal::DestroyChannel: Destroyed channel 53594e43 20:41:11.55 GAME -- Available memory: 4087MB Physical RAM, 4085MB Pagefile, 4095 Virtual Address Space 20:41:11.56 Transport - Largest received is now 19 20:41:11.56 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 20:41:14.24 DLLDriverLinker -- Adding driver 'spDx10.dll'. 20:41:14.26 DLLDriverLinker -- Adding driver 'spDx9.dll'. 20:41:14.26 DLLDriverLinker -- 2 DLL drivers found. 20:41:14.31 SPDx10 -- Adapter [AMD Radeon HD 6800 Series ]: 1012MB dedicated video memory, 0MB dedicated system memory and 1787MB shared system memory. 20:41:15.79 DLLDriverLinker -- 2 DLL drivers found. 20:41:15.88 SPOOGE - Driver[DirectX9 rendering device] version[4,36] 20:41:15.88 GAME -- Resolution set to 1920x1200 (fullscreen). 20:41:15.91 SPDx9 -- Driver Name = aticfx32.dll Desc = AMD Radeon HD 6800 Series 20:41:15.91 SPDx9 -- Driver Vendor = 0x1002 Device = 0x6739 SubSys = 0x21F81458 Rev = 0x0000 20:41:15.91 SPDx9 -- Driver Version Product = 0x0008 Version = 0x0011 SubVersion = 0x00 Build = 10.77 20:41:15.91 SPDx9 -- Driver GUID = {D7B71EE2-2479-11CF-DD73-F201BEC2C535} 20:41:16.34 SPDx9 -- 2769MB available Texture Memory 20:41:16.34 ShaderDatabase: using shader profile [ps30] 20:41:16.82 FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua' 20:41:16.96 GameObjLoader 03507908 - resetting counters 20:41:16.96 GameObjLoader 03507908 - Created loader 20:41:16.96 GameObjLoader 03507a68 - resetting counters 20:41:16.96 GameObjLoader 03507a68 - Created loader 20:41:17.18 GAME -- Beginning FE 20:41:17.18 Sent message game CompanyOfHeroes started 3544 602 allowtraffic 20:41:17.18 RemoteDLManager - Connection Restored. 20:41:17.18 UIFrontEnd - Loading Front End 20:41:17.18 THREAD: Hyper-Threading Technology Processors are not detected. 20:41:17.29 SOUND -- Initializing ... 20:41:17.35 INNIMapDCA Key not found: sp_speechducker::time 20:41:17.83 SOUND -- Initialization completed! 20:41:17.83 UIFrontEnd - Initializing Forms 20:41:19.75 CampaignFilter::BindFilterSpecificWidgets() 20:41:19.84 Activating screen: AppLoadingForm 20:41:19.84 SetupProductLoadingArt - choosing bgArt = 4 (gold=0) 20:41:19.84 Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3] 20:41:20.45 GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh] 20:41:20.46 GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1] 20:41:20.46 GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2] 20:41:20.46 GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3] 20:41:20.46 GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2] 20:41:20.46 GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1] 20:41:20.82 GAME -- Using player profile JULIAN-PC 20:41:21.73 Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase. 20:41:22.17 Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase. 20:41:22.61 QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260 20:41:22.61 RendezvousManager: CreateSession - starting profile=Guest login 20:41:25.18 RendezvousManager: Login complete and successfull 20:41:25.18 RendezvousManager initialized 20:41:25.48 Current server English:live version is 602.0, client is 602.0 20:41:25.48 OnConnect: successful connection established, enabling reconnect 20:41:25.48 OnConnect: this wasnt a reconnect, no need for autologin 20:41:25.48 Logging in nortoriousjag on controller:0 20:41:26.17 Login completed: ACCOUNT_VALIDATED 20:41:26.17 Found 1 profiles for account nortoriousjag 20:41:26.17 Found profile: NortoriousJAG 20:41:26.17 installed_products = ( COH CXP1 DLC1 DLC2 DLC3 ) 20:41:26.17 OnLogin: no previous login, auto selecting profile not required 20:41:26.17 SetupProductLoadingArt - choosing bgArt = 4 (gold=0) 20:41:26.18 CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1 20:41:26.18 Activating screen: FEMovie 20:41:26.18 Activating screen: OnlineWidget 20:41:26.18 Activating screen: RelicOnlineProfileSelect 20:41:26.20 SetupProductLoadingArt - choosing bgArt = 4 (gold=0) 20:41:26.20 Activating screen: RelicOnlineWait 20:41:26.20 RendezvousManager - destroying chat handler 20:41:26.20 RendezvousManager: CreateSession - starting logout profile = 100:Guest 20:41:26.56 RendezvousManager: Logout complete 20:41:26.56 RendezvousManager - terminating all server calls in progress 20:41:26.56 CallManager - terminating all server calls in progress (1 in progress) 20:41:26.56 RendezvousManager: OnCredentialsEvent - starting profile login 20:41:28.93 RendezvousManager: Login complete and successfull 20:41:28.93 RendezvousManager - creating chat handler 20:41:28.94 RendezvousManager::CreateNATTraversalClient - NAT traversal available. 20:41:29.23 QuazalSelectProfileAsync - Got UserID 20:41:29.24 Transport - Largest sent is now 16 20:41:29.55 Transport - Largest received is now 41 20:41:29.55 GetUserStats requested stats for PIDs ( 1643598 ) (best:0, full:1) 20:41:29.74 SelectProfileAsync - RegisterLocalURLs public [udp:/address=[IP address redacted];port=6112;PID=1643598;RVCID=44801081], private [udp:/address=[IP address redacted];port=6112;PID=1643598] 20:41:30.05 QuazalSelectProfileAsync - Got Full Stats 20:41:30.40 GetAutomatchMaps: Got [35] maps 20:41:30.42 PopulateArmyListBox - skipping race 2 20:41:30.42 PopulateArmyListBox - skipping race 0 20:41:30.42 PopulateArmyListBox - skipping race 1 20:41:30.42 PopulateArmyListBox - skipping race 3 20:41:30.42 AutoMatchForm::OnArmySelectionChanged - sending request info 20:41:30.42 GetMaxFrameTimeFromProfile: players=2 expected FPS=29.505577, bars=5, max avg=0.034, sd=0.000, 5 samples = 0.03 0.03 0.03 0.03 0.03 20:41:30.42 AutoMatchForm::OnMatchTypeSelectionChanged - sending team info 20:41:30.42 QuazalSelectProfileAsync - Got Automatch maps 20:41:32.01 QuazalSelectProfileAsync - GetFriends result - CacheState = 1 20:41:32.33 Profile [00000000:0019144e] selected on controller#0 20:41:32.33 Activating screen: FEMovie 20:41:32.33 Activating screen: OnlineWidget 20:41:32.33 Activating screen: FE_mm_01 20:41:32.33 Activating screen: RelicOnlineWait 20:41:32.33 GAME -- Setting campaign state to 'coh' 20:41:32.33 GAME -- Closing state 'coh' 20:41:32.34 GAME -- Setting campaign state to 'cxp2' 20:41:32.34 GAME -- Closing state 'cxp2' 20:41:32.34 GAME -- Setting campaign state to 'cxp1' 20:41:32.34 GAME -- Closing state 'cxp1' 20:41:32.34 GAME -- Setting campaign state to 'dlc1' 20:41:32.34 GAME -- Closing state 'dlc1' 20:41:32.34 GAME -- Setting campaign state to 'dlc2' 20:41:32.34 GAME -- Closing state 'dlc2' 20:41:32.34 GAME -- Setting campaign state to 'dlc3' 20:41:32.34 GAME -- Closing state 'dlc3' 20:41:33.49 Activating screen: MessageBoxPopup 20:41:33.49 Created Matchinfo 20:41:33.49 Session::Reset with reason 999 and AdvertisementInternal::ResetSession() 20:41:33.49 starting online hosting 20:41:33.50 OnlineHostAsync: initiating CallCreateMatch 20:41:33.82 OnlineHostAsync: created gid=182335219 20:41:33.83 Transport - Largest sent is now 78 20:41:33.90 RendezvousNotifier - Received Participate ParticipationEvent. 20:41:34.13 Transport - Largest received is now 103 20:41:34.33 OnlineHostAsync - RegisterLocalURLs public [udp:/address=[IP address redacted];port=6112;PID=1643598;RVCID=44801081], private [udp:/address=[IP address redacted];port=6112;PID=1643598] 20:41:34.64 OnlineHostAsync: initiating UpdateSessionURL [gid=182335219, url=udp:/address=[IP address redacted];port=6112;PID=1643598;RVCID=44801081] 20:41:34.94 OnJoinAdvertisementSuccess - joined online match, server leave notification required 20:41:34.94 starting local hosting 20:41:34.94 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 20:41:34.94 Allocated route ID=0 for PeerID 1 at WINaddr:[IP address redacted]:6112; 20:41:34.94 Transport::OpenInternal request to WINaddr:[IP address redacted]:6112; 20:41:34.94 Session::Host sid = ADE36F3, hostURL = , local addresses = WINaddr:[IP address redacted]:6112; 20:41:34.94 ValidateCustomData: called with 555 bytes of custom data 20:41:34.94 Host accepted Peer 1 into the match at address list=WINaddr:[IP address redacted]:6112;, routes=WINaddr:[IP address redacted]:6112; 20:41:34.94 AdvertisementInternal::Process - EVENT_NEWPEER 20:41:34.94 Session::GetState - info, session's state changed to [2:STATE_CONNECTING]. 20:41:34.96 Session::GetState - info, session's state changed to [3:STATE_CONNECTED]. 20:41:34.96 hosting - Session is connected 20:41:34.96 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:34.96 hosting completed successfully 20:41:34.96 HostAsync - completed with HostResult = 0 20:41:34.96 UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01 20:41:34.96 Activating screen: OnlineGameSetup 20:41:34.96 MessageInternal::CreateChannel: Created channel 534d5347 20:41:34.96 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 20:41:34.96 MatchInternal::SetMatchType - new type 14 - updating server 20:41:34.97 SetVisible called while !IsConnected 20:41:34.98 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 20:41:34.98 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 20:41:34.98 GetMaxFrameTimeFromProfile: players=6 expected FPS=24.166340, bars=5, max avg=0.033, sd=0.008, 5 samples = 0.02 0.04 0.04 0.04 0.03 20:41:34.98 Activating screen: RelicOnlineChat 20:41:34.98 Activating screen: RelicOnlineNewsScreen 20:41:35.04 Activating screen: RelicOnlineStatsScreen 20:41:35.04 Activating screen: Achievements 20:41:35.04 GAME -- Setting campaign state to 'coh' 20:41:35.04 GAME -- Closing state 'coh' 20:41:35.04 GAME -- Setting campaign state to 'cxp2' 20:41:35.04 GAME -- Closing state 'cxp2' 20:41:35.04 GAME -- Setting campaign state to 'cxp1' 20:41:35.04 GAME -- Closing state 'cxp1' 20:41:35.04 GAME -- Setting campaign state to 'dlc1' 20:41:35.04 GAME -- Closing state 'dlc1' 20:41:35.05 GAME -- Setting campaign state to 'dlc2' 20:41:35.05 GAME -- Closing state 'dlc2' 20:41:35.05 GAME -- Setting campaign state to 'dlc3' 20:41:35.05 GAME -- Closing state 'dlc3' 20:41:35.05 GAME -- Setting campaign state to 'dlc1' 20:41:35.05 GAME -- Closing state 'dlc1' 20:41:35.06 Activating screen: GameHistory 20:41:35.06 GAME -- Setting campaign state to 'coh' 20:41:35.06 GAME -- Closing state 'coh' 20:41:35.06 GAME -- Setting campaign state to 'cxp2' 20:41:35.06 GAME -- Closing state 'cxp2' 20:41:35.06 GAME -- Setting campaign state to 'cxp1' 20:41:35.06 GAME -- Closing state 'cxp1' 20:41:35.07 GAME -- Setting campaign state to 'dlc1' 20:41:35.07 GAME -- Closing state 'dlc1' 20:41:35.07 GAME -- Setting campaign state to 'dlc2' 20:41:35.07 GAME -- Closing state 'dlc2' 20:41:35.07 GAME -- Setting campaign state to 'dlc3' 20:41:35.07 GAME -- Closing state 'dlc3' 20:41:35.07 Activating screen: OnlineGameSetup 20:41:35.07 Activating screen: RelicOnlineTabs 20:41:35.07 AutomatchInternal::OnHostComplete - Completed Host with success=1 20:41:35.07 AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring 20:41:35.07 QuickMatchInternal::OnHostComplete - Quickmatch not in host state. 20:41:35.07 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 20:41:35.07 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:35.07 GetMaxFrameTimeFromProfile: players=6 expected FPS=24.166340, bars=5, max avg=0.033, sd=0.008, 5 samples = 0.02 0.04 0.04 0.04 0.03 20:41:35.15 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:35.17 GAME -- Setting campaign state to 'coh' 20:41:35.17 GAME -- Closing state 'coh' 20:41:35.17 GAME -- Setting campaign state to 'cxp2' 20:41:35.17 GAME -- Closing state 'cxp2' 20:41:35.17 GAME -- Setting campaign state to 'cxp1' 20:41:35.17 GAME -- Closing state 'cxp1' 20:41:35.17 GAME -- Setting campaign state to 'dlc1' 20:41:35.17 GAME -- Closing state 'dlc1' 20:41:35.17 GAME -- Setting campaign state to 'dlc2' 20:41:35.17 GAME -- Closing state 'dlc2' 20:41:35.17 GAME -- Setting campaign state to 'dlc3' 20:41:35.17 GAME -- Closing state 'dlc3' 20:41:35.18 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 20:41:35.23 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:36.00 Requesting Relic Downloader soft throttle call [GetNewsAsync] has time 820 20:41:36.00 Sent message game CompanyOfHeroes softthrottle 20:41:36.02 Got dlman msg [ack game CompanyOfHeroes softthrottle] 20:41:36.95 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 20:41:36.95 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:36.96 GetMaxFrameTimeFromProfile: players=6 expected FPS=24.166340, bars=5, max avg=0.033, sd=0.008, 5 samples = 0.02 0.04 0.04 0.04 0.03 20:41:36.96 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:36.97 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 20:41:36.99 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:37.19 Requesting Relic Downloader hard throttle call [GetNewsAsync] has time 2010 20:41:37.19 Sent message game CompanyOfHeroes hardthrottle 20:41:37.20 Got dlman msg [ack game CompanyOfHeroes hardthrottle] 20:41:38.82 QueryMatches: Got [28] maps, [61] ids, [17] advertisements, startID [1] 20:41:38.82 QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 44 matches 20:41:38.86 GetUserStats requested stats for PIDs ( 1611888 ) (best:1, full:0) 20:41:40.36 Activating screen: RaceSelectionPopup 20:41:40.83 Requesting Relic Downloader soft throttle call [GetAdvertisementsAsync] has time 810 20:41:40.83 Sent message game CompanyOfHeroes softthrottle 20:41:40.86 Got dlman msg [ack game CompanyOfHeroes softthrottle] 20:41:41.30 QueryMatches: Got [30] maps, [65] ids, [17] advertisements, startID [182334734] 20:41:41.30 QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 32 matches 20:41:42.20 Transport - Largest sent is now 79 20:41:42.47 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 20:41:42.47 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:42.47 GetMaxFrameTimeFromProfile: players=6 expected FPS=24.166340, bars=5, max avg=0.033, sd=0.008, 5 samples = 0.02 0.04 0.04 0.04 0.03 20:41:42.48 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:42.49 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 20:41:42.50 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:43.08 Activating screen: DynamicPopupMenu 20:41:44.06 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 20:41:44.06 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:44.06 GetMaxFrameTimeFromProfile: players=6 expected FPS=24.166340, bars=5, max avg=0.033, sd=0.008, 5 samples = 0.02 0.04 0.04 0.04 0.03 20:41:44.07 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:44.08 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 20:41:44.10 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:44.57 Activating screen: DynamicPopupMenu 20:41:45.69 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 20:41:45.69 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:45.69 GetMaxFrameTimeFromProfile: players=6 expected FPS=24.166340, bars=5, max avg=0.033, sd=0.008, 5 samples = 0.02 0.04 0.04 0.04 0.03 20:41:45.69 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:45.71 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 20:41:45.73 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:45.83 Requesting Relic Downloader soft throttle call [GetAdvertisementsAsync] has time 810 20:41:45.83 Sent message game CompanyOfHeroes softthrottle 20:41:45.85 Got dlman msg [ack game CompanyOfHeroes softthrottle] 20:41:45.96 QueryMatches: Got [29] maps, [63] ids, [17] advertisements, startID [182335065] 20:41:45.96 QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 13 matches 20:41:47.95 GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH 20:41:47.95 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:47.95 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:47.95 MatchInternal::SetMatchState - state 1 - updating server 20:41:47.95 Net::Session::SetVisible - session is set to INVISIBLE. 20:41:47.95 MatchSetup: Sending start game message! 20:41:47.95 GameSetupForm - Starting game 20:41:47.95 GameInfo::ResetInfo - SyncLevel set to 0 on reset 20:41:47.96 PopulateGameInfo - random seed:[1306838507], guid:[{ed477253-c25a-4eb6-80fe-413861fa35a0}], sync level:[0] 20:41:47.96 Error loading [DATA:levelingCurve.lua] 20:41:47.96 Error loading [DATA:levelingCurve.lua] 20:41:47.96 Error loading [DATA:levelingCurve.lua] 20:41:47.96 Error loading [DATA:levelingCurve.lua] 20:41:47.97 Error loading [DATA:levelingCurve.lua] 20:41:47.97 Error loading [DATA:levelingCurve.lua] 20:41:47.97 MOD - Setting player (0) race to: allies_soviets 20:41:47.97 MOD - Setting player (0) race to: 2 20:41:47.97 MOD - Setting player (1) race to: allies 20:41:47.97 MOD - Setting player (1) race to: 1 20:41:47.97 MOD - Setting player (2) race to: allies 20:41:47.97 MOD - Setting player (2) race to: 1 20:41:47.97 MOD - Setting player (3) race to: axis 20:41:47.97 MOD - Setting player (3) race to: 3 20:41:47.97 MOD - Setting player (4) race to: axis 20:41:47.97 MOD - Setting player (4) race to: 3 20:41:47.97 MOD - Setting player (5) race to: axis 20:41:47.97 MOD - Setting player (5) race to: 3 20:41:47.98 OnlineUpdateStateAsync: initiating state change, id = 182335219, state=2 20:41:47.99 APP -- Game Start 20:41:47.99 Sent message game CompanyOfHeroes allowtraffic 20:41:47.99 GAME -- Setting campaign state to 'coh' 20:41:47.99 GAME -- Closing state 'coh' 20:41:47.99 GAME -- Setting campaign state to 'cxp2' 20:41:47.99 GAME -- Closing state 'cxp2' 20:41:47.99 GAME -- Setting campaign state to 'cxp1' 20:41:47.99 GAME -- Closing state 'cxp1' 20:41:47.99 GAME -- Setting campaign state to 'dlc1' 20:41:47.99 GAME -- Closing state 'dlc1' 20:41:47.99 GAME -- Setting campaign state to 'dlc2' 20:41:47.99 GAME -- Closing state 'dlc2' 20:41:47.99 GAME -- Setting campaign state to 'dlc3' 20:41:47.99 GAME -- Closing state 'dlc3' 20:41:47.99 MessageInternal::DestroyChannel: Destroyed channel 534d5347 20:41:48.02 GAME -- Ending FE 20:41:48.02 UIFrontEnd - Unloading Front End 20:41:48.04 SOUND -- Shutting down ... 20:41:48.12 SOUND -- Shutdown completed! 20:41:48.15 20:41:48.15 GAME -- *** Beginning mission 6p_hedgerow_siege (1 Humans, 5 Computers) *** 20:41:48.15 20:41:48.45 GAME -- Recording game 20:41:48.54 Activating screen: GameLoadScreen 20:41:48.54 UpdateMatch: Call to UpdateGathering started, matchTypeID = 14. 20:41:48.54 Got dlman msg [ack game CompanyOfHeroes allowtraffic] 20:41:48.71 OnlineUpdateStateAsync: updated state for gid=182335219 20:41:48.76 THREAD: Hyper-Threading Technology Processors are not detected. 20:41:48.87 SOUND -- Initializing ... 20:41:49.62 SOUND -- Initialization completed! 20:41:49.65 PHYSICS: detected processor(s) capable of handling 4 threads. 20:41:49.71 MOD -- Locating MOD for scenario 'DATA:scenarios\mp\classic\6p_hedgerow_siege\6p_hedgerow_siege' 20:41:49.71 MOD -- Using Mod 'Eastern_Front' 20:41:49.71 Unable to load/parse precache file [DATA:scenarios\mp\classic\6p_hedgerow_siege\6p_hedgerow_siege_precache.lua] 20:41:49.79 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'. Expensive operation 20:41:49.80 Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'. Expensive operation 20:41:53.43 GameObjLoader - upgrading load_count from 0 to 1086 20:41:54.18 Requesting Relic Downloader soft throttle call [GetAdvertisementsAsync] has time 900 20:41:54.18 Sent message game CompanyOfHeroes softthrottle 20:41:54.33 Got dlman msg [ack game CompanyOfHeroes softthrottle] 20:41:54.48 QueryMatches: Got [26] maps, [63] ids, [17] advertisements, startID [182335161] 20:41:54.48 QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 2 matches 20:41:56.32 GameObjLoader - upgrading load_count from 1086 to 1799 20:41:56.33 PHYSICS -- Created node factory 'HVOK' 20:41:56.33 PHYSICS -- Created node factory 'DMMY' 20:41:58.99 Requesting Relic Downloader soft throttle call [GetAdvertisementsAsync] has time 820 20:41:58.99 Sent message game CompanyOfHeroes softthrottle 20:41:59.19 Got dlman msg [ack game CompanyOfHeroes softthrottle] 20:41:59.71 QueryMatches: Got [24] maps, [62] ids, [17] advertisements, startID [182335237] 20:42:07.40 GameObjLoader - upgrading load_count from 1463 to 4208 20:42:12.00 Transport - median kBPS [hi/cur] sent = 0.3/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.5/0.6, max unsent 0, version err 0, merge 0 20:42:14.08 GameObjLoader 03507908 - resetting counters 20:42:14.08 GameObjLoader 03507908 - LOAD_DONE 20:42:14.08 GAME - SessionSetup 20:42:14.25 CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP. 20:42:14.25 TERRAINTEXTURE -- compositor added RenderTarget [0] of size 2048 x 2048 20:42:14.25 TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024 20:42:17.23 GAME - CreateGEWorld in 3150 ms 20:42:17.24 TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed. 20:42:17.58 GAME - SessionSetup finished in 3500 ms 20:42:17.58 GAME - WaterReflectionManagerSetup 20:42:17.58 GAME - WaterReflectionManagerSetup finished in 0 ms 20:42:18.00 MessageInternal::CreateChannel: Created channel 474d4343 20:42:18.01 Regenerating ImpassMap data... 20:42:18.01 Impass Data was already valid, but regenerating... 20:42:18.30 Generating CanBuild Map. THIS SHOULD ONLY HAPPEN IN WORLDBUILDER! IF YOU SEE THIS IN GAME, RE-SAVE THE MAP! 20:42:18.30 Regenerating CanBuildMap data... 20:42:18.31 Generating CanShoot Map. 20:42:18.31 Pathfinder::Regenerate()... 20:42:18.42 Generating PathSectorMap... 20:42:19.06 Pathfinder::Regenerate() Done. [Cope FactionFix] - Trying to hook function [Cope FactionFix] - Got LuaState @0x06293708 [Cope FactionFix] - patched @0x66f45491 [Cope FactionFix] - hooked @0x66f45492 [Cope FactionFix] - patched @0x66f44a07 [Cope FactionFix] - hooked @0x66f44a07 [Cope FactionFix] - Hook installed 20:42:19.22 ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded. 20:42:19.63 MOD -- Player (unused player) (frame 0) (KillPlayer) 20:42:19.63 MOD -- Player (unused player) (frame 0) (KillPlayer) 20:42:20.30 MessageInternal::CreateChannel: Created channel 4d4f444d 20:42:21.17 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 20:42:21.17 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 20:42:21.17 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 20:42:21.17 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 20:42:21.17 BindingsSystem -- Cannot create binding. Unknown type 'repair_radius_circle' 20:42:21.88 SPEECHMANAGER -- Loaded in 0.653025 seconds 20:42:22.76 RNT_ReportPing: user 2067227:K00LYAN CANNOT connect pingMS=65535 20:42:22.76 RNT_ReportPing: user 1725594:bredlipython CANNOT connect pingMS=65535 20:42:23.51 GameObjLoader - upgrading load_count from 0 to 314 20:42:24.27 GameObjLoader 03507a68 - resetting counters 20:42:24.27 GameObjLoader 03507a68 - LOAD_DONE 20:42:25.47 PreloadResources took 1120ms. 20:42:25.60 GAME -- Loading completed (37 seconds) 20:42:25.60 SIM -- Setting SyncErrorChecking level to Low 20:42:25.86 Activating screen: GameScreen 20:42:25.86 Activating screen: Decorators_widescreen 20:42:25.86 Activating screen: Taskbar_widescreen 20:42:25.86 Activating screen: SubtitleScreen 20:42:25.86 Activating screen: TextOverlayScreen 20:42:25.99 PerformanceRecorder::StartRecording for game size 6 20:42:25.99 GAME -- Starting mission... 20:42:26.78 MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI) 20:42:26.78 MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI) 20:42:26.78 MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI) 20:42:26.78 MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI) 20:42:26.78 MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI) 20:42:31.51 Warning: non auto-match upgrade not found in AE, tuning 20:42:35.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 20:42:35.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 20:42:45.94 Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12] 20:43:13.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.5/0.2, max unsent 0, version err 0, merge 0 20:43:13.57 Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background' 20:43:21.31 Warning: binding repeat_1(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12] 20:43:36.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 20:43:36.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 20:44:14.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:44:37.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 20:44:37.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 20:45:15.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:45:38.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 20:45:38.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 20:46:16.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:46:39.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 20:46:39.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 20:47:17.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:47:40.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 20:47:40.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 20:48:18.00 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:48:41.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 20:48:41.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 20:49:19.01 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:49:42.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 20:49:42.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 20:49:49.03 Was already stealing a skeleton when told to steal another [mortar_target]. 20:50:20.01 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:50:43.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 20:50:43.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 20:50:46.26 Unable to bind updater for fx [ui\reveal]. It could be looping in a fire-n-forget action. 20:50:58.16 Was already stealing a skeleton when told to steal another [mortar_target]. 20:51:16.23 Warning: binding primary selection commands_child2() -- widget 'command_button_02' already occupied by 'command_stop_child0:' 20:51:21.01 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:51:44.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 20:51:44.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 20:52:05.60 Unabled to do upgrade, CANPRODUCE_NoResources 20:52:09.73 Unable to bind updater for fx [ui\reveal]. It could be looping in a fire-n-forget action. 20:52:22.01 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0 20:52:45.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 20:52:45.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 20:53:23.01 Transport - median kBPS [hi/cur] sent = 0.4/0.0, recvd = 0.4/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0