Crashing starts and invisible soldiers

**Ranta** · 27th Aug 12 4:34 PM

Well after years of not being able to play this game since losing my security code, I bought CoH in a digital download form over Best Buy.com and here I am after 8 hours of facepalming.

I finally downloaded CoH after 3 hours of different errors that are no longer are an issue. After that I started up the game and head into the skirmish menu to test it out. Well after starting a game and having it load all the way up, I click "Click anywhere to Start" and it crashed. After crashing it a few more times(I explain why later) it brings me back to my background of my home screen and informs me if I would like to continue to download any patches (the multiplayer patches I already downloaded) and also brings up a Crash Relic dialog box in which it ask me what I did before I crashed and if I'd like to report it. I send a report and it tells me the drivers are outdated (this coming from a game 4 years old). It then shows me how I can update them through intel.com and if that should not work it shows how to go to intel support.

Now I have tried changing the graphics, thinking that might be the problem since 1-2 times I have actually started playing a match only to realize I can't see the units might be the problem( when for an hour all I did was wait and crash over and over again). Well after that failed, I went to intel.com and did what it told me to do and updated my Graphics Driver as it was the only one that had an update available. In doing that it allowed me to once again get a foot into the game but crashed not long after without the ability once again to see the engineers. It brought me back to the message again telling me to update my drivers... so this is when the face palming ends and the questioning begins.
As far as the listed 4 things needed, I have hijackedthis report, and it is massive. I also have the massive warnings report in of which I am not posting right now due to the already huge size of this post. Since I have Windows 7, Run is not on my Start screen, I do not know how to do the dxdiag.txt option.

Listen I'm sure you really don't want to deal with this, if you even are on this forum since it's only 4 years old but I could really use some help before I call THQ with a very pissy attitude.

So thankyou to anyone who would like to take the time and help me.
Ranta

**Ranta** · 27th Aug 12 4:51 PM

This is the warnings report

Code:

RELICCOH started at 2012-08-27 16:19
OS NT 6.1 (sp0.0) x64, 3002MB Physical Memory, 1348 Physical Available, 3980 Virtual Available
RUN-OPTIONS 
WORKING-DIR C:\Program Files (x86)\THQ\Company of Heroes
USER Ryan

16:19:34.71   2 Logical Processors detected
16:19:34.71   Multithreading Enabled
16:19:34.71   THREAD: Hyper-Threading Technology Processors are not detected.
16:19:34.71   XTHREAD: Detected 2 core(s) with 2 hardware thread(s)
16:19:34.71   XTHREAD: Main thread now used as XThread 0
16:19:34.71   XTHREAD: Spawned thread on processor 1
16:19:34.71   MATHBOX -- Version=6, Cpu=Intel Pentium III:f=6,m=7, Mode=SSE
16:19:34.71   GAME -- Company Of Heroes, 2.602.0, Build live.2.602.0, Type live, Language English
16:19:34.72   MOD -- Mounting RelicDLC1, 1.0
16:19:34.73   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ryan\Documents\My Games\Company of Heroes\DLC1\Movies\'
16:19:34.73   MOD -- Mounting RelicDLC2, 1.0
16:19:34.73   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ryan\Documents\My Games\Company of Heroes\DLC2\Movies\'
16:19:34.73   MOD -- Mounting RelicDLC3, 1.0
16:19:34.73   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ryan\Documents\My Games\Company of Heroes\DLC3\Movies\'
16:19:34.73   MOD -- Mounting RelicOps, 1.0
16:19:34.73   MOD -- Mounting RelicCoH, 1.0
16:19:34.83   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ryan\Documents\My Games\Company of Heroes\Engine\Movies\'
16:19:34.83   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ryan\Documents\My Games\Company of Heroes\WW2\Movies\'
16:19:34.93   GAME -- Resetting fp control word.
16:19:38.95   WW2Mod -- PropertyBagManager Loaded in 4.018000s
16:19:39.02   NetworkManager::Create - creating network manager
16:19:39.02   Read 230 bytes from network datastore login_cache.bin
16:19:39.02   Read 52 bytes from network datastore global_cache.bin
16:19:39.02   Read 28 bytes from network datastore ping_cache.bin
16:19:39.02   QuazalInitializer - static initializing Quazal library
16:19:39.02   PingCache - populating cache with 0 pings
16:19:39.02   Sent message game CompanyOfHeroes started 6044 602 allowtraffic
16:19:39.02   RemoteDLManager - Connection Restored.
16:19:39.02   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
16:19:39.02   WinTransport - CreateSocket exclusive broadcast socket was available.
16:19:39.02   WinTransport - CreateSocket listening for broadcasts on default port
16:19:39.03   WinTransport - Host Name: Ryan-PC, aliases: , type=AF_INET, len=4
16:19:39.03   WinTransport - Host IP Address #0: 192.168.1.4
16:19:39.03   WinTransport - Interface #0: ip:192.168.1.4, broadcast:192.168.1.4, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
16:19:39.03   WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
16:19:39.03   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
16:19:39.03   WinTransport - Quazal address string = udp:/address=192.168.1.4;port=6112
16:19:39.03   SessionManager - Peer Header Size = 16 bytes
16:19:39.03   SessionManager - Game Data overhead = 7 bytes
16:19:39.03   SessionManager - Proxy overhead = 7 bytes
16:19:39.03   MessageInternal::CreateChannel: Created channel 47535450
16:19:39.03   Session::Initialize - info, initializing session object, using threads.
16:19:39.03   SessionManager::RegisterSession - Registering new session 03b15de0
16:19:39.03   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
16:19:39.03   AutomatchInternal: Instantiating
16:19:39.03   PartyInternal: Instantiating
16:19:39.03   MessageInternal::CreateChannel: Created channel 50525459
16:19:39.03   MessageInternal::CreateChannel: Created channel 51434b4d
16:19:39.03   Net::ThreadFunction - Entering network thread function...
16:19:39.03   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
16:19:39.03   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:19:39.03   MessageInternal::CreateChannel: Created channel 534d5347
16:19:39.03   MessageInternal::CreateChannel: Created channel 474d4343
16:19:39.03   MessageInternal::CreateChannel: Created channel 474f424a
16:19:39.03   MessageInternal::CreateChannel: Created channel 4d4f444d
16:19:39.03   MessageInternal::CreateChannel: Created channel 53594e43
16:19:39.03   MessageInternal::DestroyChannel: Destroyed channel 534d5347
16:19:39.03   MessageInternal::DestroyChannel: Destroyed channel 474d4343
16:19:39.03   MessageInternal::DestroyChannel: Destroyed channel 474f424a
16:19:39.03   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
16:19:39.03   MessageInternal::DestroyChannel: Destroyed channel 53594e43
16:19:39.04   GAME -- Available memory: 3002MB Physical RAM, 3001MB Pagefile, 4095 Virtual Address Space
16:19:39.05   Transport - Largest received is now 19
16:19:39.05   Transport::OpenInternal request to WINaddr:192.168.1.4:6112;
16:19:39.72   DLLDriverLinker -- Adding driver 'spDx10.dll'.
16:19:39.73   DLLDriverLinker -- Adding driver 'spDx9.dll'.
16:19:39.73   DLLDriverLinker -- 2 DLL drivers found.
16:19:39.76   SPDx10 -- Adapter [Mobile Intel(R) 4 Series Express Chipset Family]: 64MB dedicated video memory, 0MB dedicated system memory and 1245MB shared system memory.
16:19:41.31   DLLDriverLinker -- 2 DLL drivers found.
16:19:41.35   SPOOGE - Driver[DirectX10 Rendering Device] version[4,36]
16:19:41.35   GAME -- Resolution set to 1360x768 (fullscreen).
16:19:41.38   SPDx10 -- Adapter Description = Mobile Intel(R) 4 Series Express Chipset Family
16:19:41.38   SPDx10 -- Driver Vendor = 0x00008086  Device = 0x00002a42  SubSys = 0x1484103c  Rev = 0x00000007
16:19:41.38   SPDx10 -- Driver Version  Product = 0x0008  Version = 0x000f  SubVersion = 0x00  Build = 22.02
16:19:41.38   SPDx10 -- Driver LUID = 0x00000000-0x000077c7
16:19:41.38   SPDx10 -- 64MB dedicated video memory, 0MB dedicated system memory and 1245MB shared system memory available.
16:19:41.38   SPDx10 -- Unknown video driver, assuming [1] GPUs.
16:19:41.38   ShaderDatabase: using shader profile [ps40]
16:19:41.79   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
16:19:42.25   GameObjLoader 0cfec398 - resetting counters
16:19:42.25   GameObjLoader 0cfec398 - Created loader
16:19:42.25   GameObjLoader 0cfec4f8 - resetting counters
16:19:42.25   GameObjLoader 0cfec4f8 - Created loader
16:19:42.77   GAME -- Beginning FE
16:19:42.78   Sent message game CompanyOfHeroes allowtraffic
16:19:42.78   UIFrontEnd - Loading Front End
16:19:42.78   THREAD: Hyper-Threading Technology Processors are not detected.
16:19:42.88   SOUND -- Initializing ...
16:19:42.94   INNIMapDCA Key not found: sp_speechducker::time
16:19:43.25   SOUND -- Initialization completed!
16:19:43.25   UIFrontEnd - Initializing Forms
16:19:45.11   CampaignFilter::BindFilterSpecificWidgets()
16:19:45.25   Activating screen: MovieScreen
16:19:45.27   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
16:20:40.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
16:21:32.37   Activating screen: AppLoadingForm
16:21:32.37   SetupProductLoadingArt - choosing bgArt = 0 (gold=0)
16:21:33.93   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
16:21:33.93   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
16:21:33.93   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
16:21:33.94   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
16:21:33.96   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
16:21:33.97   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
16:21:37.04   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
16:21:37.11   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
16:21:37.39   GAME -- Using player profile RYAN-PC
16:21:41.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
16:22:42.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
16:22:49.63   Dx10Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
16:23:01.79   Dx10Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
16:23:21.76   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
16:23:21.76   RendezvousManager: CreateSession - starting profile=Guest login
16:23:22.63   RendezvousManager: Login complete and successfull
16:23:22.65   RendezvousManager initialized
16:23:22.75   Current server English:live version is 602.0, client is 602.0
16:23:22.77   OnConnect: successful connection established, enabling reconnect
16:23:22.77   OnConnect: this wasnt a reconnect, no need for autologin
16:23:22.80   SetupProductLoadingArt - choosing bgArt = 0 (gold=0)
16:23:22.81   CRC & Version Info : 0000025a:924f95e6:ec3c9e0d reliccoh:602:ww2mod.dll 0
16:23:22.81   Activating screen: FEMovie
16:23:22.81   Activating screen: OnlineWidget
16:23:22.81   Activating screen: RelicOnlineLogin
16:23:22.90   SetupProductLoadingArt - choosing bgArt = 0 (gold=0)
16:23:22.90   You have a valid version of the game.
16:23:36.33   Activating screen: RelicOnlineAccountCreate
16:23:36.33   Activating screen: RelicOnlineWait
16:23:43.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
16:24:38.65   RelicOnlineAccountCreate::VerifyCDKeys - ignoring key from entry 1 as it has an improper length
16:24:38.65   RelicOnlineAccountCreate::VerifyCDKeys - ignoring key from entry 2 as it has an improper length
16:24:38.65   Activating screen: RelicOnlineWait
16:24:38.80   Activating screen: RelicOnlineAgreement
16:24:38.80   Activating screen: RelicOnlineWait
16:24:38.83   Already have a key bailing
16:24:41.74   RelicOnlineAccountCreate::CreateAccountFromUserData
16:24:41.74   Activating screen: RelicOnlineAccountCreate
16:24:41.74   Activating screen: RelicOnlineWait
16:24:41.74   Already have a key bailing
16:24:41.89   Activating screen: MessageBoxPopup
16:24:41.89   Activating screen: RelicOnlineWait
16:24:41.89   Activating screen: RelicOnlineWait
16:24:44.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
16:25:15.92   RelicOnlineAccountCreate::VerifyCDKeys - ignoring key from entry 1 as it has an improper length
16:25:15.92   RelicOnlineAccountCreate::VerifyCDKeys - ignoring key from entry 2 as it has an improper length
16:25:15.92   Activating screen: RelicOnlineWait
16:25:16.07   Activating screen: RelicOnlineAgreement
16:25:16.07   Activating screen: RelicOnlineWait
16:25:16.13   Already have a key bailing
16:25:18.14   RelicOnlineAccountCreate::CreateAccountFromUserData
16:25:18.14   Activating screen: RelicOnlineAccountCreate
16:25:18.14   Activating screen: RelicOnlineWait
16:25:18.14   Already have a key bailing
16:25:18.31   Activating screen: MessageBoxPopup
16:25:18.31   Activating screen: RelicOnlineWait
16:25:18.31   Activating screen: RelicOnlineWait
16:25:45.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.3, max unsent 0, version err 0, merge 0
16:25:52.92   RelicOnlineAccountCreate::VerifyCDKeys - ignoring key from entry 1 as it has an improper length
16:25:52.92   RelicOnlineAccountCreate::VerifyCDKeys - ignoring key from entry 2 as it has an improper length
16:25:52.92   Activating screen: RelicOnlineWait
16:25:53.12   Activating screen: RelicOnlineAgreement
16:25:53.12   Activating screen: RelicOnlineWait
16:25:53.18   Already have a key bailing
16:25:54.80   RelicOnlineAccountCreate::CreateAccountFromUserData
16:25:54.80   Activating screen: RelicOnlineAccountCreate
16:25:54.80   Activating screen: RelicOnlineWait
16:25:54.80   Already have a key bailing
16:25:55.64   Requesting Relic Downloader soft throttle call [CreateAccountAsync] has time 840
16:25:55.64   Sent message game CompanyOfHeroes softthrottle
16:25:55.67   Got dlman msg [ack game CompanyOfHeroes softthrottle]
16:25:56.85   Logging in Sullivans on controller:0
16:25:57.29   Login completed: ACCOUNT_VALIDATED
16:25:57.29   Found 1 profiles for account Sullivans
16:25:57.29   Found profile: Sullivans
16:25:57.29   installed_products = ( COH )
16:25:57.29   Activating screen: RelicOnlineProfileSelect
16:25:57.29   Activating screen: RelicOnlineWait
16:25:57.29   Activating screen: MessageBoxPopup
16:25:57.29   Activating screen: RelicOnlineWait
16:25:57.29   Activating screen: RelicOnlineWait
16:25:57.29   OnLogin: no previous login, auto selecting profile not required
16:26:03.44   RelicOnlineProfileSelect::OnClickBack - transitioning to RelicOnlineLogin
16:26:03.44   Activating screen: MessageBoxPopup
16:26:13.94   Activating screen: RelicOnlineWait
16:26:13.94   RendezvousManager - destroying chat handler
16:26:13.95   RendezvousManager: CreateSession - starting logout profile = 100:Guest
16:26:14.32   RendezvousManager: Logout complete
16:26:14.32   RendezvousManager - terminating all server calls in progress
16:26:14.32   CallManager - terminating all server calls in progress (1 in progress)
16:26:14.32   RendezvousManager: OnCredentialsEvent - starting profile login
16:26:15.23   RendezvousManager: Login complete and successfull
16:26:15.23   RendezvousManager - creating chat handler
16:26:15.24   RendezvousManager::CreateNATTraversalClient - NAT traversal available.
16:26:15.55   QuazalSelectProfileAsync - Got UserID
16:26:15.60   Transport - Largest sent is now 16
16:26:15.68   Transport - Largest received is now 43
16:26:15.76   GetUserStats requested stats for PIDs ( 4781346 ) (best:0, full:1)
16:26:15.85   SelectProfileAsync - RegisterLocalURLs public [udp:/address=72.184.232.160;port=6112;PID=4781346;RVCID=44575554], private [udp:/address=192.168.1.4;port=6112;PID=4781346]
16:26:15.98   QuazalSelectProfileAsync - Got Full Stats
16:26:16.20   GetAutomatchMaps: Got [32] maps
16:26:16.24   PopulateArmyListBox - skipping race 2
16:26:16.24   PopulateArmyListBox - skipping race 0
16:26:16.24   PopulateArmyListBox - skipping race 1
16:26:16.24   PopulateArmyListBox - skipping race 3
16:26:16.24   AutoMatchForm::OnArmySelectionChanged - sending request info
16:26:16.24   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:16.24   AutoMatchForm::OnMatchTypeSelectionChanged - sending team info
16:26:16.29   QuazalSelectProfileAsync - Got Automatch maps
16:26:17.16   QuazalSelectProfileAsync - GetFriends result - CacheState = 1
16:26:17.33   Profile [00000000:0048f522] selected on controller#0
16:26:17.33   Activating screen: FEMovie
16:26:17.33   Activating screen: OnlineWidget
16:26:17.33   Activating screen: FE_mm_01
16:26:17.33   Activating screen: RelicOnlineWait
16:26:19.79   Activating screen: MessageBoxPopup
16:26:19.79   Created Matchinfo
16:26:19.79   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:26:19.79   starting online hosting
16:26:19.85   OnlineHostAsync: initiating CallCreateMatch
16:26:19.99   OnlineHostAsync: created gid=254744497
16:26:20.00   Transport - Largest sent is now 80
16:26:20.09   Transport - Largest received is now 107
16:26:20.13   RendezvousNotifier - Received Participate ParticipationEvent.
16:26:20.27   OnlineHostAsync - RegisterLocalURLs public [udp:/address=72.184.232.160;port=6112;PID=4781346;RVCID=44575554], private [udp:/address=192.168.1.4;port=6112;PID=4781346]
16:26:20.37   OnlineHostAsync: initiating UpdateSessionURL [gid=254744497, url=udp:/address=72.184.232.160;port=6112;PID=4781346;RVCID=44575554]
16:26:20.61   OnJoinAdvertisementSuccess - joined online match, server leave notification required
16:26:20.61   starting local hosting
16:26:20.61   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
16:26:20.61   Allocated route ID=0 for PeerID 1 at WINaddr:192.168.1.4:6112;
16:26:20.61   Transport::OpenInternal request to WINaddr:192.168.1.4:6112;
16:26:20.61   Session::Host sid = F2F17B1, hostURL = , local addresses = WINaddr:192.168.1.4:6112;
16:26:20.61   ValidateCustomData: called with 186 bytes of custom data
16:26:20.61   Host accepted Peer 1 into the match at address list=WINaddr:192.168.1.4:6112;, routes=WINaddr:192.168.1.4:6112;
16:26:20.61   AdvertisementInternal::Process - EVENT_NEWPEER
16:26:20.61   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:26:20.64   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.1.4:6112; (ping=0ms) 100.00%, pending=0, dead=0
16:26:20.64   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
16:26:20.66   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:26:20.66   hosting - Session is connected
16:26:20.66   Net::Session::SetVisible - session is set to INVISIBLE.
16:26:20.70   hosting completed successfully
16:26:20.70   HostAsync - completed with HostResult = 0
16:26:20.70   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
16:26:20.70   Activating screen: OnlineGameSetup
16:26:20.70   MessageInternal::CreateChannel: Created channel 534d5347
16:26:20.70   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:26:20.70   MatchInternal::SetMatchType - new type 14 - updating server
16:26:20.77   SetVisible called while !IsConnected
16:26:20.77   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:20.77   Activating screen: RelicOnlineChat
16:26:20.78   Activating screen: RelicOnlineNewsScreen
16:26:20.78   Activating screen: RelicOnlineStatsScreen
16:26:20.78   Activating screen: Achievements
16:26:20.78   GAME -- Setting campaign state to 'coh'
16:26:20.78   GAME -- Closing state 'coh'
16:26:20.80   Activating screen: GameHistory
16:26:20.80   GAME -- Setting campaign state to 'coh'
16:26:20.80   GAME -- Closing state 'coh'
16:26:20.82   Activating screen: OnlineGameSetup
16:26:20.82   Activating screen: RelicOnlineTabs
16:26:20.82   Activating screen: ScreenTipPopup
16:26:20.82   AutomatchInternal::OnHostComplete - Completed Host with success=1
16:26:20.82   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
16:26:20.82   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
16:26:20.83   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:26:20.83   Net::Session::SetVisible - session is set to INVISIBLE.
16:26:20.83   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:21.14   Activating screen: ScreenTipPopup
16:26:21.14   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:21.15   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:26:21.33   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:21.35   GAME -- Setting campaign state to 'coh'
16:26:21.35   GAME -- Closing state 'coh'
16:26:22.00   Requesting Relic Downloader soft throttle call [GetNewsAsync] has time 852
16:26:22.00   Sent message game CompanyOfHeroes softthrottle
16:26:22.00   Got dlman msg [ack game CompanyOfHeroes softthrottle]
16:26:22.61   QueryMatches: Got [47] maps, [134] ids, [17] advertisements, startID [1]
16:26:22.61   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 117 matches
16:26:25.61   QueryMatches: Got [49] maps, [136] ids, [17] advertisements, startID [254741943]
16:26:25.61   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 102 matches
16:26:30.56   QueryMatches: Got [47] maps, [140] ids, [17] advertisements, startID [254743280]
16:26:30.57   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 89 matches
16:26:31.56   Activating screen: RaceSelectionPopup
16:26:33.29   Activating screen: ScreenTipPopup
16:26:35.54   QueryMatches: Got [49] maps, [137] ids, [17] advertisements, startID [254743724]
16:26:35.55   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 72 matches
16:26:36.78   Activating screen: RaceSelectionPopup
16:26:40.50   QueryMatches: Got [45] maps, [135] ids, [17] advertisements, startID [254744072]
16:26:40.50   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 55 matches
16:26:44.22   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:26:44.22   Net::Session::SetVisible - session is set to INVISIBLE.
16:26:44.22   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:44.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:44.46   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:45.71   QueryMatches: Got [46] maps, [139] ids, [17] advertisements, startID [254744178]
16:26:45.72   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 43 matches
16:26:46.01   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
16:26:49.44   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:26:49.44   Net::Session::SetVisible - session is set to INVISIBLE.
16:26:49.44   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:49.64   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:49.75   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:50.60   QueryMatches: Got [46] maps, [137] ids, [17] advertisements, startID [254744354]
16:26:50.61   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 26 matches
16:26:54.08   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:26:54.08   Net::Session::SetVisible - session is set to INVISIBLE.
16:26:54.09   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:54.12   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:54.17   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:55.43   QueryMatches: Got [43] maps, [134] ids, [17] advertisements, startID [254744455]
16:26:55.43   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 8 matches
16:26:56.39   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:26:56.39   Net::Session::SetVisible - session is set to INVISIBLE.
16:26:56.39   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:56.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:56.60   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:58.65   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:26:58.65   Net::Session::SetVisible - session is set to INVISIBLE.
16:26:58.65   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:26:58.73   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:26:58.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:00.74   QueryMatches: Got [43] maps, [134] ids, [17] advertisements, startID [254744538]
16:27:00.75   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 3 matches
16:27:00.88   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:00.88   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:00.89   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:01.02   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:01.13   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:02.95   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:02.95   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:02.95   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:03.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:03.14   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:05.29   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:05.29   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:05.30   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:05.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:05.46   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:05.94   QueryMatches: Got [45] maps, [139] ids, [17] advertisements, startID [254739045]
16:27:05.95   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 10 matches
16:27:08.68   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:08.68   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:08.68   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:08.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:08.96   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:10.85   QueryMatches: Got [47] maps, [141] ids, [17] advertisements, startID [254742718]
16:27:10.86   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 15 matches
16:27:11.85   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:11.85   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:11.85   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:12.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:12.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:15.83   QueryMatches: Got [48] maps, [138] ids, [17] advertisements, startID [254743714]
16:27:15.84   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 16 matches
16:27:16.40   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:16.40   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:16.41   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:16.57   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:16.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:20.46   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:20.46   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:20.47   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:20.63   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:20.75   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:20.77   QueryMatches: Got [47] maps, [138] ids, [17] advertisements, startID [254744056]
16:27:20.77   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 18 matches
16:27:21.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.1.4:6112; (ping=0ms) 100.00%, pending=0, dead=0
16:27:21.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
16:27:25.72   QueryMatches: Got [49] maps, [138] ids, [17] advertisements, startID [254744215]
16:27:25.72   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 21 matches
16:27:26.59   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:26.59   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:26.59   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:26.73   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:26.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:26.86   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:27:29.85   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:29.85   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:29.85   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:30.01   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:30.03   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:27:30.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:30.66   QueryMatches: Got [49] maps, [139] ids, [17] advertisements, startID [254744389]
16:27:30.66   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 26 matches
16:27:33.21   Transport - Largest sent is now 81
16:27:33.46   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:33.46   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:33.46   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:33.65   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:33.66   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:27:33.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:35.65   QueryMatches: Got [50] maps, [136] ids, [17] advertisements, startID [254744536]
16:27:35.65   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 19 matches
16:27:36.28   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:36.28   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:36.28   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:36.42   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:36.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:38.84   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:38.84   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:38.84   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:39.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:39.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:40.59   QueryMatches: Got [51] maps, [138] ids, [17] advertisements, startID [254744612]
16:27:40.60   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 8 matches
16:27:41.99   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:41.99   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:41.99   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:42.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:42.27   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:44.43   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:44.43   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:44.43   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:44.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:44.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:45.57   QueryMatches: Got [50] maps, [135] ids, [17] advertisements, startID [254744677]
16:27:45.58   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 3 matches
16:27:47.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.1/0.1, max unsent 0, version err 0, merge 0
16:27:47.16   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:47.16   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:47.17   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:47.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:47.44   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:49.54   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:49.54   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:49.54   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:49.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:49.82   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:50.89   QueryMatches: Got [50] maps, [138] ids, [17] advertisements, startID [254739045]
16:27:50.90   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 9 matches
16:27:52.14   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:52.14   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:52.14   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:52.31   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:52.40   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:54.20   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:54.20   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:54.20   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:54.33   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:54.40   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:55.54   QueryMatches: Got [51] maps, [144] ids, [17] advertisements, startID [254742934]
16:27:55.55   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 16 matches
16:27:57.89   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:27:57.89   Net::Session::SetVisible - session is set to INVISIBLE.
16:27:57.90   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:27:57.94   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:27:57.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:00.68   QueryMatches: Got [51] maps, [144] ids, [17] advertisements, startID [254743723]
16:28:00.69   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 17 matches
16:28:03.31   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:03.31   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:03.32   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:03.44   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:03.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:03.57   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:05.63   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:05.63   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:05.63   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:05.69   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:05.71   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:05.71   QueryMatches: Got [52] maps, [143] ids, [17] advertisements, startID [254744110]
16:28:05.72   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 20 matches
16:28:05.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:07.98   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:07.98   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:07.99   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:08.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:08.13   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:08.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:10.19   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:10.19   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:10.20   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:10.43   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:10.45   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:10.58   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:10.71   QueryMatches: Got [49] maps, [148] ids, [17] advertisements, startID [254744317]
16:28:10.71   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 26 matches
16:28:12.71   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:12.71   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:12.71   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:12.90   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:12.92   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:13.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:15.00   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:15.00   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:15.00   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:15.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:15.24   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:15.35   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:15.93   QueryMatches: Got [50] maps, [147] ids, [17] advertisements, startID [254744517]
16:28:15.93   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 28 matches
16:28:17.32   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:17.32   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:17.32   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:17.46   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:17.48   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:17.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:20.31   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:20.31   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:20.31   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:20.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:20.50   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:20.58   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:20.77   QueryMatches: Got [50] maps, [147] ids, [17] advertisements, startID [254744639]
16:28:20.78   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 26 matches
16:28:22.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.1.4:6112; (ping=0ms) 100.00%, pending=0, dead=0
16:28: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
16:28:23.97   RNT_ReportPing: user 58878:Trihead2 CANNOT connect pingMS=65535
16:28:24.40   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:24.40   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:24.40   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:24.63   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:24.64   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:24.71   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:25.53   QueryMatches: Got [51] maps, [151] ids, [17] advertisements, startID [254744709]
16:28:25.54   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 15 matches
16:28:28.44   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:28.44   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:28.44   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:28.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:28.60   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:28.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:30.51   QueryMatches: Got [51] maps, [149] ids, [17] advertisements, startID [254744759]
16:28:30.52   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 2 matches
16:28:30.52   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:30.52   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:30.52   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:30.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:30.63   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:30.68   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:32.91   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:32.91   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:32.92   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:32.99   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:33.00   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:33.05   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:35.40   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:35.40   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:35.40   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:35.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:35.51   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:35.55   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:35.66   QueryMatches: Got [52] maps, [149] ids, [17] advertisements, startID [254744820]
16:28:35.66   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 3 matches
16:28:38.60   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:38.60   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:38.60   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:38.69   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:38.70   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:38.75   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:40.60   QueryMatches: Got [51] maps, [146] ids, [17] advertisements, startID [254741943]
16:28:40.61   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 6 matches
16:28:42.36   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:42.36   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:42.36   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:42.45   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:42.47   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:42.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:45.60   QueryMatches: Got [50] maps, [146] ids, [17] advertisements, startID [254743442]
16:28:45.60   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 10 matches
16:28:45.78   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:45.78   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:45.78   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:45.83   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:45.84   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:45.89   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:47.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:47.49   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:48.00   Transport - median kBPS [hi/cur] sent = 1.4/0.6, recvd = 1.2/0.5, #p/sec[s/r] = 7.2/5.9, max unsent 0, version err 0, merge 0
16:28:49.03   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:49.03   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:49.04   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:49.10   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:49.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:49.23   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:50.67   QueryMatches: Got [48] maps, [143] ids, [17] advertisements, startID [254743992]
16:28:50.68   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 13 matches
16:28:55.08   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:55.08   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:55.09   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:55.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:55.17   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:55.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:55.71   QueryMatches: Got [48] maps, [140] ids, [17] advertisements, startID [254744267]
16:28:55.72   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 14 matches
16:28:58.58   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:28:58.58   Net::Session::SetVisible - session is set to INVISIBLE.
16:28:58.58   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:28:58.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:28:58.68   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:28:58.74   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:00.79   QueryMatches: Got [48] maps, [145] ids, [17] advertisements, startID [254744503]
16:29:00.80   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 23 matches
16:29:05.63   QueryMatches: Got [48] maps, [142] ids, [17] advertisements, startID [254744679]
16:29:05.64   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 24 matches
16:29:06.40   Activating screen: DynamicPopupMenu
16:29:09.04   Activating screen: DynamicPopupMenu
16:29:10.83   QueryMatches: Got [49] maps, [145] ids, [17] advertisements, startID [254744748]
16:29:10.83   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 24 matches
16:29:12.48   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:29:12.48   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:12.48   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:29:12.53   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:12.54   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:29:12.58   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:14.31   Activating screen: DynamicPopupMenu
16:29:15.47   QueryMatches: Got [46] maps, [140] ids, [17] advertisements, startID [254744849]
16:29:15.48   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 4 matches
16:29:16.16   Activating screen: DynamicPopupMenu
16:29:17.76   Activating screen: DynamicPopupMenu
16:29:18.88   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:29:18.88   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:18.89   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:29:18.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:18.93   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
16:29:18.97   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:19.58   Activating screen: DynamicPopupMenu
16:29:20.57   QueryMatches: Got [46] maps, [144] ids, [17] advertisements, startID [254744905]
16:29:20.58   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 2 matches
16:29:21.15   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:29:21.15   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:21.15   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:29:21.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:21.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:23.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.1.4:6112; (ping=0ms) 100.00%, pending=0, dead=0
16:29:23.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
16:29:24.76   Activating screen: DynamicPopupMenu
16:29:25.63   QueryMatches: Got [48] maps, [145] ids, [17] advertisements, startID [254741137]
16:29:25.64   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 8 matches
16:29:26.07   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:29:26.07   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:26.07   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:29:26.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:26.16   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:30.06   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:29:30.06   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:30.06   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:29:30.10   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:30.16   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:30.60   QueryMatches: Got [47] maps, [148] ids, [17] advertisements, startID [254743280]
16:29:30.61   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 13 matches
16:29:35.49   QueryMatches: Got [50] maps, [147] ids, [17] advertisements, startID [254744041]
16:29:35.49   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 16 matches
16:29:36.65   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:29:36.65   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:36.65   GetMaxFrameTimeFromProfile: players=4 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
16:29:36.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:36.76   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:40.50   QueryMatches: Got [47] maps, [145] ids, [17] advertisements, startID [254744419]
16:29:40.51   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 17 matches
16:29:42.03   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
16:29:42.03   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:42.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:42.03   MatchInternal::SetMatchState - state 1 - updating server
16:29:42.03   Net::Session::SetVisible - session is set to INVISIBLE.
16:29:42.03   MatchSetup: Sending start game message!
16:29:42.03   GameSetupForm - Starting game
16:29:42.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
16:29:42.03   PopulateGameInfo - random seed:[1346099382], guid:[{aac437cb-b054-42af-a74b-73079cce8d25}], sync level:[0]
16:29:42.03   Error loading [DATA:levelingCurve.lua]
16:29:42.03   Error loading [DATA:levelingCurve.lua]
16:29:42.03   MOD - Setting player (0) race to: allies
16:29:42.03   MOD - Setting player (0) race to: 1
16:29:42.03   MOD - Setting player (1) race to: axis
16:29:42.03   MOD - Setting player (1) race to: 2
16:29:42.04   OnlineUpdateStateAsync: initiating state change, id = 254744497, state=2
16:29:42.07   APP -- Game Start
16:29:42.08   Sent message game CompanyOfHeroes allowtraffic
16:29:42.08   GAME -- Setting campaign state to 'coh'
16:29:42.08   GAME -- Closing state 'coh'
16:29:42.08   MessageInternal::DestroyChannel: Destroyed channel 534d5347
16:29:42.09   GAME -- Ending FE
16:29:42.09   UIFrontEnd - Unloading Front End
16:29:42.11   SOUND -- Shutting down ...
16:29:42.17   SOUND -- Shutdown completed!
16:29:42.27
16:29:42.27   GAME -- *** Beginning mission 4p_vire river valley (1 Humans, 1 Computers) ***
16:29:42.27
16:29:42.53   GAME -- Recording game
16:29:42.64   Activating screen: GameLoadScreen
16:29:42.64   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
16:29:43.01   OnlineUpdateStateAsync: updated state for gid=254744497
16:29:43.26   THREAD: Hyper-Threading Technology Processors are not detected.
16:29:43.39   SOUND -- Initializing ...
16:29:43.93   SOUND -- Initialization completed!
16:29:44.01   PHYSICS: detected processor(s) capable of handling 2 threads.
16:29:44.02   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\classic\4p_vire river valley\4p_vire river valley'
16:29:44.02   MOD -- Using Mod 'RelicCoH'
16:29:44.05   Unable to load/parse precache file [DATA:scenarios\mp\classic\4p_vire river valley\4p_vire river valley_precache.lua]
16:29:44.14   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_03_edit_load.smf'.  Expensive operation
16:29:44.15   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_03_edit_load.smf'.  Expensive operation
16:29:45.72   GameObjLoader - upgrading load_count from 0 to 1008
16:29:46.18   QueryMatches: Got [46] maps, [147] ids, [17] advertisements, startID [254744608]
16:29:46.19   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 21 matches
16:29:46.95   RendezvousNotifier - Received Participate ParticipationEvent.
16:29:47.25   GameObjLoader - upgrading load_count from 1008 to 1680
16:29:47.29   PHYSICS -- Created node factory 'HVOK'
16:29:47.29   PHYSICS -- Created node factory 'DMMY'
16:29:49.01   Transport - median kBPS [hi/cur] sent = 1.4/0.0, recvd = 1.2/0.0, #p/sec[s/r] = 2.8/2.4, max unsent 0, version err 0, merge 0
16:29:50.81   QueryMatches: Got [48] maps, [145] ids, [17] advertisements, startID [254744733]
16:29:50.82   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 21 matches
16:29:52.68   Transport - Largest received is now 346
16:29:52.68   Transport::OpenInternal request to WINaddr:78.29.186.135:6112;
16:29:52.68   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; not currently in use
16:29:52.68   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
16:29:52.68   Session::CheckAddress - initiating address check for WINaddr:192.168.1.2:6112;
16:29:52.68   Allocated route ID=0 for PeerID 2 at WINaddr:78.29.186.135:6112;
16:29:52.68   Transport::OpenInternal request to WINaddr:78.29.186.135:6112;
16:29:52.68   Peer::AcceptRoute - accepted route 5<>11 WINaddr:78.29.186.135:6112; for peerID:2
16:29:52.68   Session - generating NewPeerAcceptedEventEx for peer 2@WINaddr:78.29.186.135:6112;
16:29:53.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:53.06   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; in use by pending peer (ignoring)
16:29:53.46   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; in use by pending peer (ignoring)
16:29:53.86   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; in use by pending peer (ignoring)
16:29:54.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:54.24   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; in use by pending peer (ignoring)
16:29:54.66   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; in use by pending peer (ignoring)
16:29:55.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:55.04   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; in use by pending peer (ignoring)
16:29:55.33   ValidateCustomData: called with 453 bytes of custom data
16:29:55.33   Session denying join, reason 109 reasonDebug no slot available for this user
16:29:55.33   Session::DestroyPeer - deallocating peer 2
16:29:55.33   Session - Requested Disconnect for connectionID 4
16:29:55.33   Deallocated route ID=5 for PeerID 2 at WINaddr:78.29.186.135:6112;
16:29:55.33   Session - Requested Disconnect for connectionID 5
16:29:55.33   Closed route 5<>11 for PeerID 2 at WINaddr:78.29.186.135:6112;
16:29:55.34   Transport - Largest sent is now 345
16:29:55.44   Session - rcv'd Join request - address WINaddr:78.29.186.135:6112; not currently in use
16:29:55.44   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
16:29:55.44   Session::CheckAddress - initiating address check for WINaddr:192.168.1.2:6112;
16:29:55.44   Allocated route ID=0 for PeerID 3 at WINaddr:78.29.186.135:6112;
16:29:55.44   Transport::OpenInternal request to WINaddr:78.29.186.135:6112;
16:29:55.44   Peer::AcceptRoute - accepted route 7<>11 WINaddr:78.29.186.135:6112; for peerID:3
16:29:55.44   Session - generating NewPeerAcceptedEventEx for peer 3@WINaddr:78.29.186.135:6112;
16:29:55.50   ValidateCustomData: called with 453 bytes of custom data
16:29:55.50   Session denying join, reason 109 reasonDebug no slot available for this user
16:29:55.50   Session::DestroyPeer - deallocating peer 3
16:29:55.50   Session - Requested Disconnect for connectionID 6
16:29:55.50   Deallocated route ID=7 for PeerID 3 at WINaddr:78.29.186.135:6112;
16:29:55.50   Session - Requested Disconnect for connectionID 7
16:29:55.50   Closed route 7<>11 for PeerID 3 at WINaddr:78.29.186.135:6112;
16:29:55.95   QueryMatches: Got [49] maps, [146] ids, [17] advertisements, startID [254744861]
16:29:55.96   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 24 matches
16:29:55.96   RNT_CancelParticipation: user 4677584:romazini left the match
16:29:56.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:56.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:57.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:57.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:58.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:58.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:59.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:59.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:29:59.47   GameObjLoader - upgrading load_count from 18 to 3749
16:30:00.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:00.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:00.81   QueryMatches: Got [47] maps, [145] ids, [17] advertisements, startID [254744936]
16:30:00.82   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 10 matches
16:30:01.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:01.00   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:02.01   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:02.01   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:03.01   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:03.01   Session::ProcessCheckAddressList - address WINaddr:192.168.1.2:6112; timed out
16:30:03.01   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:04.01   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:04.01   GameObjLoader 0cfec398 - resetting counters
16:30:04.01   GameObjLoader 0cfec398 - LOAD_DONE
16:30:04.01   GAME - SessionSetup
16:30:05.01   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:06.01   Session::ProcessCheckAddressList - sending address check to WINaddr:192.168.1.2:6112;
16:30:06.01   Session::ProcessCheckAddressList - address WINaddr:192.168.1.2:6112; timed out
16:30:07.93   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
16:30:07.93   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
16:30:07.93   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
16:30:18.24   GAME - CreateGEWorld in 14232 ms
16:30:18.24   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
16:30:18.72   GAME - SessionSetup finished in 14712 ms
16:30:18.73   GAME - WaterReflectionManagerSetup
16:30:18.73   GAME - WaterReflectionManagerSetup finished in 0 ms
16:30:19.09   MessageInternal::CreateChannel: Created channel 474d4343
16:30:19.09   QueryMatches: Got [44] maps, [150] ids, [17] advertisements, startID [254744991]
16:30:19.10   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 11 matches
16:30:19.38   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/ZANNIHILATE.SCAR] succeeded.
16:30:22.59   MOD -- Player  (unused player) (frame 0) (KillPlayer)
16:30:22.59   MOD -- Player  (unused player) (frame 0) (KillPlayer)
16:30:22.59   MOD -- Player  (unused player) (frame 0) (KillPlayer)
16:30:22.59   MOD -- Player  (unused player) (frame 0) (KillPlayer)
16:30:22.59   MOD -- Player  (unused player) (frame 0) (KillPlayer)
16:30:22.59   MOD -- Player  (unused player) (frame 0) (KillPlayer)
16:30:23.09   MessageInternal::CreateChannel: Created channel 4d4f444d
16:30:24.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.1.4:6112; (ping=0ms) 100.00%, pending=0, dead=0
16:30:24.01   MessageCounts: inval=0/0, seek=0/0, join=0/8, integ=0/0, seek_reply=0/0, join_reply=2/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=22/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=9/9, frag=0/0, Errors=0/0
16:30:24.06   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
16:30:24.07   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
16:30:24.07   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
16:30:24.08   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
16:30:24.08   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
16:30:24.17   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_03_edit_load.smf'.  Expensive operation
16:30:24.71   SPEECHMANAGER -- Loaded in 0.572847 seconds
16:30:26.44   GameObjLoader - upgrading load_count from 0 to 1562
16:30:26.99   QueryMatches: Got [43] maps, [151] ids, [17] advertisements, startID [254745053]
16:30:27.02   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 3 matches
16:30:28.45   GameObjLoader 0cfec4f8 - resetting counters
16:30:28.45   GameObjLoader 0cfec4f8 - LOAD_DONE
16:30:32.95   QueryMatches: Got [43] maps, [151] ids, [17] advertisements, startID [254739982]
16:30:32.96   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 3 matches
16:30:32.96   PreloadResources took 0ms.
16:30:33.06   GAME -- Loading completed (50 seconds)
16:30:33.06   SIM -- Setting SyncErrorChecking level to Low
16:30:33.53   QueryMatches: Got [44] maps, [146] ids, [17] advertisements, startID [254743442]
16:30:33.54   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 6 matches

This is the Hijackthis report

Code:

Logfile of Trend Micro HijackThis v2.0.4
Scan saved at 7:28:56 PM, on 8/27/2012
Platform: Windows 7 (WinNT 6.00.3504)
MSIE: Internet Explorer v9.00 (9.00.8112.16448)
Boot mode: Normal

Running processes:
C:\Program Files (x86)\Common Files\LightScribe\LightScribeControlPanel.exe
C:\Users\Ryan\AppData\Roaming\Spotify\Data\SpotifyWebHelper.exe
C:\Program Files (x86)\HP\HP Software Update\hpwuschd2.exe
C:\Program Files (x86)\Common Files\Adobe\ARM\1.0\AdobeARM.exe
C:\Program Files (x86)\Common Files\Java\Java Update\jusched.exe
C:\Program Files (x86)\Hewlett-Packard\Shared\hpqToaster.exe
C:\Users\Ryan\AppData\Local\Google\Chrome\Application\chrome.exe
C:\Users\Ryan\AppData\Local\Google\Chrome\Application\chrome.exe
C:\Users\Ryan\AppData\Local\Google\Chrome\Application\chrome.exe
C:\Users\Ryan\AppData\Local\Google\Chrome\Application\chrome.exe
C:\Users\Ryan\AppData\Local\Google\Chrome\Application\chrome.exe
C:\Users\Ryan\Downloads\HiJackThis.exe

R1 - HKCU\Software\Microsoft\Internet Explorer\Main,Search Page = http://go.microsoft.com/fwlink/?LinkId=54896
R1 - HKLM\Software\Microsoft\Internet Explorer\Main,Default_Page_URL = http://g.msn.com/HPNOT/1
R1 - HKLM\Software\Microsoft\Internet Explorer\Main,Default_Search_URL = http://go.microsoft.com/fwlink/?LinkId=54896
R1 - HKLM\Software\Microsoft\Internet Explorer\Main,Search Page = http://go.microsoft.com/fwlink/?LinkId=54896
R0 - HKLM\Software\Microsoft\Internet Explorer\Main,Start Page = http://g.msn.com/HPNOT/1
R0 - HKLM\Software\Microsoft\Internet Explorer\Search,SearchAssistant = 
R0 - HKLM\Software\Microsoft\Internet Explorer\Search,CustomizeSearch = 
R0 - HKLM\Software\Microsoft\Internet Explorer\Main,Local Page = C:\Windows\SysWOW64\blank.htm
R1 - HKCU\Software\Microsoft\Internet Explorer\Main,Window Title = Internet Explorer, optimized for Bing and MSN
R1 - HKCU\Software\Microsoft\Windows\CurrentVersion\Internet Settings,ProxyServer = http=127.0.0.1:54646
R1 - HKCU\Software\Microsoft\Windows\CurrentVersion\Internet Settings,ProxyOverride = *.local
R0 - HKCU\Software\Microsoft\Internet Explorer\Toolbar,LinksFolderName = 
F3 - REG:win.ini: load=C:\Users\Ryan\AppData\Local\Temp\csrss.exe
F2 - REG:system.ini: UserInit=userinit.exe
O2 - BHO: HP Print Enhancer - {0347C33E-8762-4905-BF09-768834316C61} - C:\Program Files (x86)\HP\Digital Imaging\Smart Web Printing\hpswp_printenhancer.dll
O2 - BHO: AcroIEHelperStub - {18DF081C-E8AD-4283-A596-FA578C2EBDC3} - C:\Program Files (x86)\Common Files\Adobe\Acrobat\ActiveX\AcroIEHelperShim.dll
O2 - BHO: Java(tm) Plug-In SSV Helper - {761497BB-D6F0-462C-B6EB-D4DAF1D92D43} - C:\Program Files (x86)\Java\jre7\bin\ssv.dll
O2 - BHO: Windows Live ID Sign-in Helper - {9030D464-4C02-4ABF-8ECC-5164760863C6} - C:\Program Files (x86)\Common Files\Microsoft Shared\Windows Live\WindowsLiveLogin.dll
O2 - BHO: URLRedirectionBHO - {B4F3A835-0E21-4959-BA22-42B3008E02FF} - C:\PROGRA~2\MICROS~3\Office14\URLREDIR.DLL
O2 - BHO: Microsoft Live Search Toolbar Helper - {d2ce3e00-f94a-4740-988e-03dc2f38c34f} - c:\Program Files (x86)\MSN\Toolbar\3.0.0566.0\msneshellx.dll
O2 - BHO: Java(tm) Plug-In 2 SSV Helper - {DBC80044-A445-435b-BC74-9C25C1C588A9} - C:\Program Files (x86)\Java\jre7\bin\jp2ssv.dll
O2 - BHO: HP Smart BHO Class - {FFFFFFFF-CF4E-4F2B-BDC2-0E72E116A856} - C:\Program Files (x86)\HP\Digital Imaging\Smart Web Printing\hpswp_BHO.dll
O3 - Toolbar: Microsoft Live Search Toolbar - {1E61ED7C-7CB8-49d6-B9E9-AB4C880C8414} - c:\Program Files (x86)\MSN\Toolbar\3.0.0566.0\msneshellx.dll
O4 - HKLM\..\Run: [NortonOnlineBackupReminder] "C:\Program Files (x86)\Symantec\Norton Online Backup\Activation\NobuActivation.exe" UNATTENDED
O4 - HKLM\..\Run: [Adobe Reader Speed Launcher] "C:\Program Files (x86)\Adobe\Reader 9.0\Reader\Reader_sl.exe"
O4 - HKLM\..\Run: [HP Software Update] C:\Program Files (x86)\Hp\HP Software Update\HPWuSchd2.exe
O4 - HKLM\..\Run: [WirelessAssistant] C:\Program Files (x86)\Hewlett-Packard\HP Wireless Assistant\HPWAMain.exe
O4 - HKLM\..\Run: [Sprint SmartView] "C:\Program Files (x86)\Sprint\Sprint SmartView\SprintSV.exe" -a
O4 - HKLM\..\Run: [Adobe ARM] "C:\Program Files (x86)\Common Files\Adobe\ARM\1.0\AdobeARM.exe"
O4 - HKLM\..\Run: [SunJavaUpdateSched] "C:\Program Files (x86)\Common Files\Java\Java Update\jusched.exe"
O4 - HKCU\..\Run: [LightScribe Control Panel] C:\Program Files (x86)\Common Files\LightScribe\LightScribeControlPanel.exe -hidden
O4 - HKCU\..\Run: [HPADVISOR] C:\Program Files (x86)\Hewlett-Packard\HP Advisor\HPAdvisor.exe view=DOCKVIEW
O4 - HKCU\..\Run: [Spotify] "C:\Users\Ryan\AppData\Roaming\Spotify\Spotify.exe" /uri spotify:autostart
O4 - HKCU\..\Run: [Spotify Web Helper] "C:\Users\Ryan\AppData\Roaming\Spotify\Data\SpotifyWebHelper.exe"
O4 - HKCU\..\Run: [Google Update] "C:\Users\Ryan\AppData\Local\Google\Update\GoogleUpdate.exe" /c
O4 - .DEFAULT User Startup: Best Buy pc app.lnk = C:\ProgramData\Best Buy pc app\ClickOnceSetup.exe (User 'Default user')
O4 - Global Startup: PictureMover.lnk = C:\Program Files (x86)\PictureMover\Bin\PictureMover.exe
O9 - Extra button: @C:\Program Files (x86)\Windows Live\Writer\WindowsLiveWriterShortcuts.dll,-1004 - {219C3416-8CB2-491a-A3C7-D9FCDDC9D600} - C:\Program Files (x86)\Windows Live\Writer\WriterBrowserExtension.dll
O9 - Extra 'Tools' menuitem: @C:\Program Files (x86)\Windows Live\Writer\WindowsLiveWriterShortcuts.dll,-1003 - {219C3416-8CB2-491a-A3C7-D9FCDDC9D600} - C:\Program Files (x86)\Windows Live\Writer\WriterBrowserExtension.dll
O9 - Extra button: Send to OneNote - {2670000A-7350-4f3c-8081-5663EE0C6C49} - C:\Program Files (x86)\Microsoft Office\Office14\ONBttnIE.dll
O9 - Extra 'Tools' menuitem: Se&nd to OneNote - {2670000A-7350-4f3c-8081-5663EE0C6C49} - C:\Program Files (x86)\Microsoft Office\Office14\ONBttnIE.dll
O9 - Extra button: OneNote Lin&ked Notes - {789FE86F-6FC4-46A1-9849-EDE0DB0C95CA} - C:\Program Files (x86)\Microsoft Office\Office14\ONBttnIELinkedNotes.dll
O9 - Extra 'Tools' menuitem: OneNote Lin&ked Notes - {789FE86F-6FC4-46A1-9849-EDE0DB0C95CA} - C:\Program Files (x86)\Microsoft Office\Office14\ONBttnIELinkedNotes.dll
O9 - Extra button: Show or hide HP Smart Web Printing - {DDE87865-83C5-48c4-8357-2F5B1AA84522} - C:\Program Files (x86)\HP\Digital Imaging\Smart Web Printing\hpswp_BHO.dll
O10 - Unknown file in Winsock LSP: c:\program files (x86)\common files\microsoft shared\windows live\wlidnsp.dll
O10 - Unknown file in Winsock LSP: c:\program files (x86)\common files\microsoft shared\windows live\wlidnsp.dll
O11 - Options group: [ACCELERATED_GRAPHICS] Accelerated graphics
O18 - Protocol: wlpg - {E43EF6CD-A37A-4A9B-9E6F-83F89B8E6324} - C:\Program Files (x86)\Windows Live\Photo Gallery\AlbumDownloadProtocolHandler.dll
O18 - Filter hijack: text/xml - {807573E5-5146-11D5-A672-00B0D022E945} - C:\Program Files (x86)\Common Files\Microsoft Shared\OFFICE14\MSOXMLMF.DLL
O23 - Service: Andrea RT Filters Service (AERTFilters) - Andrea Electronics Corporation - C:\Program Files\Realtek\Audio\HDA\AERTSr64.exe
O23 - Service: Agere Modem Call Progress Audio (AgereModemAudio) - LSI Corporation - C:\Program Files\LSI SoftModem\agr64svc.exe
O23 - Service: @%SystemRoot%\system32\Alg.exe,-112 (ALG) - Unknown owner - C:\Windows\System32\alg.exe (file missing)
O23 - Service: Bonjour Service - Apple Inc. - C:\Program Files\Bonjour\mDNSResponder.exe
O23 - Service: Sprint Con App Svc (CASprint) - PCTEL - C:\Program Files (x86)\Sprint\Sprint SmartView\ConAppsSvc.exe
O23 - Service: @%SystemRoot%\system32\efssvc.dll,-100 (EFS) - Unknown owner - C:\Windows\System32\lsass.exe (file missing)
O23 - Service: @%systemroot%\system32\fxsresm.dll,-118 (Fax) - Unknown owner - C:\Windows\system32\fxssvc.exe (file missing)
O23 - Service: GameConsoleService - WildTangent, Inc. - C:\Program Files (x86)\HP Games\HP Game Console\GameConsoleService.exe
O23 - Service: Google Update Service (gupdate) (gupdate) - Google Inc. - C:\Program Files (x86)\Google\Update\GoogleUpdate.exe
O23 - Service: Google Update Service (gupdatem) (gupdatem) - Google Inc. - C:\Program Files (x86)\Google\Update\GoogleUpdate.exe
O23 - Service: HP Health Check Service - Hewlett-Packard - C:\Program Files (x86)\Hewlett-Packard\HP Health Check\hphc_service.exe
O23 - Service: hpqwmiex - Hewlett-Packard Company - C:\Program Files (x86)\Hewlett-Packard\Shared\hpqwmiex.exe
O23 - Service: HPWMISVC - Unknown owner - C:\Program Files\Hewlett-Packard\HP Quick Launch\HPWMISVC.exe
O23 - Service: @keyiso.dll,-100 (KeyIso) - Unknown owner - C:\Windows\system32\lsass.exe (file missing)
O23 - Service: LightScribeService Direct Disc Labeling Service (LightScribeService) - Hewlett-Packard Company - C:\Program Files (x86)\Common Files\LightScribe\LSSrvc.exe
O23 - Service: @comres.dll,-2797 (MSDTC) - Unknown owner - C:\Windows\System32\msdtc.exe (file missing)
O23 - Service: @%SystemRoot%\System32\netlogon.dll,-102 (Netlogon) - Unknown owner - C:\Windows\system32\lsass.exe (file missing)
O23 - Service: @%systemroot%\system32\psbase.dll,-300 (ProtectedStorage) - Unknown owner - C:\Windows\system32\lsass.exe (file missing)
O23 - Service: Cyberlink RichVideo Service(CRVS) (RichVideo) - Unknown owner - C:\Program Files (x86)\CyberLink\Shared files\RichVideo.exe
O23 - Service: @%systemroot%\system32\Locator.exe,-2 (RpcLocator) - Unknown owner - C:\Windows\system32\locator.exe (file missing)
O23 - Service: @%SystemRoot%\system32\samsrv.dll,-1 (SamSs) - Unknown owner - C:\Windows\system32\lsass.exe (file missing)
O23 - Service: @%SystemRoot%\system32\snmptrap.exe,-3 (SNMPTRAP) - Unknown owner - C:\Windows\System32\snmptrap.exe (file missing)
O23 - Service: @%systemroot%\system32\spoolsv.exe,-1 (Spooler) - Unknown owner - C:\Windows\System32\spoolsv.exe (file missing)
O23 - Service: @%SystemRoot%\system32\sppsvc.exe,-101 (sppsvc) - Unknown owner - C:\Windows\system32\sppsvc.exe (file missing)
O23 - Service: Sprint RcAppSvc (SprintRcAppSvc) - PCTEL - C:\Program Files (x86)\Sprint\Sprint SmartView\RcAppSvc.exe
O23 - Service: @%SystemRoot%\system32\ui0detect.exe,-101 (UI0Detect) - Unknown owner - C:\Windows\system32\UI0Detect.exe (file missing)
O23 - Service: @%SystemRoot%\system32\vaultsvc.dll,-1003 (VaultSvc) - Unknown owner - C:\Windows\system32\lsass.exe (file missing)
O23 - Service: @%SystemRoot%\system32\vds.exe,-100 (vds) - Unknown owner - C:\Windows\System32\vds.exe (file missing)
O23 - Service: @%systemroot%\system32\vssvc.exe,-102 (VSS) - Unknown owner - C:\Windows\system32\vssvc.exe (file missing)
O23 - Service: @%SystemRoot%\system32\Wat\WatUX.exe,-601 (WatAdminSvc) - Unknown owner - C:\Windows\system32\Wat\WatAdminSvc.exe (file missing)
O23 - Service: @%systemroot%\system32\wbengine.exe,-104 (wbengine) - Unknown owner - C:\Windows\system32\wbengine.exe (file missing)
O23 - Service: @%Systemroot%\system32\wbem\wmiapsrv.exe,-110 (wmiApSrv) - Unknown owner - C:\Windows\system32\wbem\WmiApSrv.exe (file missing)
O23 - Service: @%PROGRAMFILES%\Windows Media Player\wmpnetwk.exe,-101 (WMPNetworkSvc) - Unknown owner - C:\Program Files (x86)\Windows Media Player\wmpnetwk.exe (file missing)

--
End of file - 11198 bytes

Crashing starts and invisible soldiers

Thread Tools

Crashing starts and invisible soldiers

Thread Information

Users Browsing this Thread

Posting Permissions