-- Log file for all dbTracef messages --

15:28:23.74   NetworkManager::Create - creating network manager
15:28:23.74   Read 567 bytes from network datastore login_cache.bin
15:28:23.74   Read 52 bytes from network datastore global_cache.bin
15:28:23.74   Read 28 bytes from network datastore ping_cache.bin
15:28:23.75   QuazalInitializer - static initializing Quazal library
15:28:23.75   PingCache - populating cache with 0 pings
15:28:23.90   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
15:28:23.92   WinTransport - CreateSocket exclusive broadcast socket was available.
15:28:23.92   WinTransport - CreateSocket listening for broadcasts on default port
15:28:23.93   WinTransport - Host Name: Alex-PC, aliases: , type=AF_INET, len=4
15:28:23.93   WinTransport - Host IP Address #0: 192.168.0.199
15:28:23.93   WinTransport - Interface #0: ip:192.168.0.199, broadcast:192.168.0.199, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
15:28:23.93   WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
15:28:23.93   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
15:28:23.93   WinTransport - Quazal address string = udp:/address=192.168.0.199;port=6112
15:28:23.93   SessionManager - Peer Header Size = 16 bytes
15:28:23.93   SessionManager - Game Data overhead = 7 bytes
15:28:23.93   SessionManager - Proxy overhead = 7 bytes
15:28:23.93   MessageInternal::CreateChannel: Created channel 47535450
15:28:23.93   Session::Initialize - info, initializing session object, using threads.
15:28:23.93   SessionManager::RegisterSession - Registering new session 036f5dd8
15:28:23.93   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
15:28:23.93   Net::ThreadFunction - Entering network thread function...
15:28:23.93   AutomatchInternal: Instantiating
15:28:23.93   PartyInternal: Instantiating
15:28:23.93   MessageInternal::CreateChannel: Created channel 50525459
15:28:23.93   MessageInternal::CreateChannel: Created channel 51434b4d
15:28:23.95   Transport - Largest received is now 19
15:28:23.95   Transport::OpenInternal request to WINaddr:192.168.0.199:6112;
15:28:23.97   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
15:28:23.97   MessageInternal::CreateChannel: Created channel 534d5347
15:28:23.97   MessageInternal::CreateChannel: Created channel 474d4343
15:28:23.97   MessageInternal::CreateChannel: Created channel 474f424a
15:28:23.97   MessageInternal::CreateChannel: Created channel 4d4f444d
15:28:23.97   MessageInternal::CreateChannel: Created channel 53594e43
15:28:23.97   MessageInternal::DestroyChannel: Destroyed channel 534d5347
15:28:23.97   MessageInternal::DestroyChannel: Destroyed channel 474d4343
15:28:23.97   MessageInternal::DestroyChannel: Destroyed channel 474f424a
15:28:23.97   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
15:28:23.97   MessageInternal::DestroyChannel: Destroyed channel 53594e43
15:28:23.97   GAME -- Available memory: 3325MB Physical RAM, 3526MB Pagefile, 2047 Virtual Address Space
15:28:28.79   DLLDriverLinker -- Adding driver 'spDx10.dll'.
15:28:28.96   DLLDriverLinker -- Adding driver 'spDx9.dll'.
15:28:28.96   DLLDriverLinker -- 2 DLL drivers found.
15:28:29.09   SPDx10 -- Adapter [NVIDIA GeForce 8800 GT ]: 497MB dedicated video memory, 0MB dedicated system memory and 1407MB shared system memory.
15:28:30.85   DLLDriverLinker -- 2 DLL drivers found.
15:28:31.05   SPOOGE - Driver[DirectX10 Rendering Device] version[4,36]
15:28:31.05   GAME -- Resolution set to 1280x768 (fullscreen).
15:28:31.10   SPDx10 -- Adapter Description = NVIDIA GeForce 8800 GT
15:28:31.10   SPDx10 -- Driver Vendor = 0x000010de  Device = 0x00000611  SubSys = 0x080110b0  Rev = 0x000000a2
15:28:31.10   SPDx10 -- Driver Version  Product = 0x0008  Version = 0x0011  SubVersion = 0x00  Build = 196.21
15:28:31.10   SPDx10 -- Driver LUID = 0x00000000-0x0000fcca
15:28:31.10   SPDx10 -- 497MB dedicated video memory, 0MB dedicated system memory and 1407MB shared system memory available.
15:28:31.15   ShaderDatabase: using shader profile [ps40]
15:28:33.24   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
15:28:33.71   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
15:28:33.73   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
15:28:34.80   GameObjLoader 027ba240 - resetting counters
15:28:34.80   GameObjLoader 027ba240 - Created loader
15:28:34.80   GameObjLoader 027ba3a0 - resetting counters
15:28:34.80   GameObjLoader 027ba3a0 - Created loader
15:28:35.68   GAME -- Beginning FE
15:28:35.68   Sent message game CompanyOfHeroes started 5908 601 allowtraffic
15:28:35.68   RemoteDLManager - Connection Restored.
15:28:35.68   UIFrontEnd - Loading Front End
15:28:35.68   THREAD: Hyper-Threading Technology Processors are not detected.
15:28:35.93   SOUND -- Initializing ...
15:28:36.06   INNIMapDCA Key not found: sp_speechducker::time
15:28:36.97   SOUND -- Initialization completed!
15:28:36.97   UIFrontEnd - Initializing Forms
15:28:39.39   CampaignFilter::BindFilterSpecificWidgets()
15:28:39.48   Activating screen: AppLoadingForm
15:28:39.48   SetupProductLoadingArt - choosing bgArt = 0 (gold=0)
15:28:39.48   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
15:28:42.09   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
15:28:42.09   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
15:28:42.09   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
15:28:42.11   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
15:28:42.13   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
15:28:42.13   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
15:28:42.64   GAME -- Using player profile ALEX-PC
15:28:43.95   Dx10Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
15:28:44.66   Dx10Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
15:28:47.98   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
15:28:47.98   RendezvousManager: CreateSession - starting profile=Guest login
15:28:49.17   RendezvousManager: Login complete and successfull
15:28:49.17   RendezvousManager initialized
15:28:49.32   Current server English:live version is 601.0, client is 601.0
15:28:49.32   OnConnect: successful connection established, enabling reconnect
15:28:49.32   OnConnect: this wasnt a reconnect, no need for autologin
15:28:49.32   Logging in xB1aSTeRx on controller:0
15:28:49.70   Login completed: ACCOUNT_VALIDATED
15:28:49.70   Found 1 profiles for account xB1aSTeRx
15:28:49.70   Found profile: xB1aSTeRx
15:28:49.70   installed_products = ( DLC1 DLC2 DLC3 CXP1 COH )
15:28:49.70   OnLogin: no previous login, auto selecting profile not required
15:28:49.70   SetupProductLoadingArt - choosing bgArt = 2 (gold=0)
15:28:49.70   CRC & Version Info : 00000259:6aa29d62:48d2c5df eastern_front:601:ww2mod.dll 1
15:28:49.72   Activating screen: FEMovie
15:28:49.72   Activating screen: OnlineWidget
15:28:49.72   Activating screen: RelicOnlineProfileSelect
15:28:49.83   SetupProductLoadingArt - choosing bgArt = 2 (gold=0)
15:28:49.83   Activating screen: RelicOnlineWait
15:28:49.83   RendezvousManager - destroying chat handler
15:28:49.83   RendezvousManager: CreateSession - starting logout profile = 100:Guest
15:28:50.02   RendezvousManager: Logout complete
15:28:50.02   RendezvousManager - terminating all server calls in progress
15:28:50.02   CallManager - terminating all server calls in progress (1 in progress)
15:28:50.02   RendezvousManager: OnCredentialsEvent - starting profile login
15:28:51.12   RendezvousManager: Login complete and successfull
15:28:51.13   RendezvousManager - creating chat handler
15:28:51.13   RendezvousManager::CreateNATTraversalClient - NAT traversal available.
15:28:51.26   QuazalSelectProfileAsync - Got UserID
15:28:51.27   Transport - Largest sent is now 16
15:28:51.40   Transport - Largest received is now 42
15:28:51.42   GetUserStats requested stats for PIDs ( 3052293 ) (best:0, full:1)
15:28:51.52   SelectProfileAsync - RegisterLocalURLs public [udp:/address=90.231.136.27;port=6112;PID=3052293;RVCID=87370534], private [udp:/address=192.168.0.199;port=6112;PID=3052293]
15:28:51.66   QuazalSelectProfileAsync - Got Full Stats
15:28:51.80   GetAutomatchMaps: Got [32] maps
15:28:51.82   PopulateArmyListBox - skipping race 2
15:28:51.82   PopulateArmyListBox - skipping race 0
15:28:51.82   PopulateArmyListBox - skipping race 1
15:28:51.82   PopulateArmyListBox - skipping race 3
15:28:51.82   AutoMatchForm::OnArmySelectionChanged - sending request info
15:28:51.82   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
15:28:51.82   AutoMatchForm::OnMatchTypeSelectionChanged - sending team info
15:28:51.82   QuazalSelectProfileAsync - Got Automatch maps
15:28:52.70   QuazalSelectProfileAsync - GetFriends result - CacheState = 1
15:28:52.84   Profile [00000000:002e9305] selected on controller#0
15:28:52.84   Activating screen: FEMovie
15:28:52.84   Activating screen: OnlineWidget
15:28:52.84   Activating screen: FE_mm_01
15:28:52.84   Activating screen: RelicOnlineWait
15:28:52.86   GAME -- Setting campaign state to 'coh'
15:28:52.86   GAME -- Closing state 'coh'
15:28:52.86   GAME -- Setting campaign state to 'cxp2'
15:28:52.86   GAME -- Closing state 'cxp2'
15:28:52.87   GAME -- Setting campaign state to 'cxp1'
15:28:52.87   GAME -- Closing state 'cxp1'
15:28:52.87   GAME -- Setting campaign state to 'dlc1'
15:28:52.87   GAME -- Closing state 'dlc1'
15:28:52.88   GAME -- Setting campaign state to 'dlc2'
15:28:52.88   GAME -- Closing state 'dlc2'
15:28:52.88   GAME -- Setting campaign state to 'dlc3'
15:28:52.88   GAME -- Closing state 'dlc3'
15:29:24.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
15:30:25.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
15:31:26.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
15:32:27.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
15:33:28.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
15:34:29.00   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
15:35:05.69   Activating screen: MessageBoxPopup
15:35:05.69   Created Matchinfo
15:35:05.69   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
15:35:05.69   starting online hosting
15:35:05.70   OnlineHostAsync: initiating CallCreateMatch
15:35:05.87   OnlineHostAsync: created gid=151864466
15:35:05.87   RendezvousNotifier - Received Participate ParticipationEvent.
15:35:05.87   Transport - Largest sent is now 79
15:35:06.00   Transport - Largest received is now 105
15:35:06.13   OnlineHostAsync - RegisterLocalURLs public [udp:/address=90.231.136.27;port=6112;PID=3052293;RVCID=87370534], private [udp:/address=192.168.0.199;port=6112;PID=3052293]
15:35:06.26   OnlineHostAsync: initiating UpdateSessionURL [gid=151864466, url=udp:/address=90.231.136.27;port=6112;PID=3052293;RVCID=87370534]
15:35:06.43   OnJoinAdvertisementSuccess - joined online match, server leave notification required
15:35:06.43   starting local hosting
15:35:06.43   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
15:35:06.43   Allocated route ID=0 for PeerID 1 at WINaddr:192.168.0.199:6112;
15:35:06.43   Transport::OpenInternal request to WINaddr:192.168.0.199:6112;
15:35:06.43   Session::Host sid = 90D4492, hostURL = , local addresses = WINaddr:192.168.0.199:6112;
15:35:06.43   ValidateCustomData: called with 463 bytes of custom data
15:35:06.43   Host accepted Peer 1 into the match at address list=WINaddr:192.168.0.199:6112;, routes=WINaddr:192.168.0.199:6112;
15:35:06.43   AdvertisementInternal::Process - EVENT_NEWPEER
15:35:06.43   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
15:35:06.44   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
15:35:06.44   hosting - Session is connected
15:35:06.44   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:06.45   hosting completed successfully
15:35:06.45   HostAsync - completed with HostResult = 0
15:35:06.45   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
15:35:06.45   Activating screen: OnlineGameSetup
15:35:06.45   MessageInternal::CreateChannel: Created channel 534d5347
15:35:06.45   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:06.45   MatchInternal::SetMatchType - new type 14 - updating server
15:35:06.46   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
15:35:06.46   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
15:35:06.48   SetVisible called while !IsConnected
15:35:06.48   GetMaxFrameTimeFromProfile: players=6 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
15:35:06.49   Activating screen: RelicOnlineChat
15:35:06.49   Activating screen: RelicOnlineNewsScreen
15:35:06.49   Activating screen: RelicOnlineStatsScreen
15:35:06.49   Activating screen: Achievements
15:35:06.49   GAME -- Setting campaign state to 'coh'
15:35:06.49   GAME -- Closing state 'coh'
15:35:06.50   GAME -- Setting campaign state to 'cxp2'
15:35:06.50   GAME -- Closing state 'cxp2'
15:35:06.50   GAME -- Setting campaign state to 'cxp1'
15:35:06.50   GAME -- Closing state 'cxp1'
15:35:06.51   GAME -- Setting campaign state to 'dlc1'
15:35:06.51   GAME -- Closing state 'dlc1'
15:35:06.51   GAME -- Setting campaign state to 'dlc2'
15:35:06.51   GAME -- Closing state 'dlc2'
15:35:06.52   GAME -- Setting campaign state to 'dlc3'
15:35:06.52   GAME -- Closing state 'dlc3'
15:35:06.52   GAME -- Setting campaign state to 'dlc1'
15:35:06.52   GAME -- Closing state 'dlc1'
15:35:06.53   Activating screen: GameHistory
15:35:06.53   GAME -- Setting campaign state to 'coh'
15:35:06.54   GAME -- Closing state 'coh'
15:35:06.54   GAME -- Setting campaign state to 'cxp2'
15:35:06.54   GAME -- Closing state 'cxp2'
15:35:06.54   GAME -- Setting campaign state to 'cxp1'
15:35:06.55   GAME -- Closing state 'cxp1'
15:35:06.55   GAME -- Setting campaign state to 'dlc1'
15:35:06.55   GAME -- Closing state 'dlc1'
15:35:06.55   GAME -- Setting campaign state to 'dlc2'
15:35:06.56   GAME -- Closing state 'dlc2'
15:35:06.56   GAME -- Setting campaign state to 'dlc3'
15:35:06.56   GAME -- Closing state 'dlc3'
15:35:06.56   Activating screen: OnlineGameSetup
15:35:06.56   Activating screen: RelicOnlineTabs
15:35:06.56   AutomatchInternal::OnHostComplete - Completed Host with success=1
15:35:06.56   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
15:35:06.56   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
15:35:06.57   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:06.57   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:06.57   GetMaxFrameTimeFromProfile: players=6 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
15:35:06.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:06.74   GAME -- Setting campaign state to 'coh'
15:35:06.74   GAME -- Closing state 'coh'
15:35:06.74   GAME -- Setting campaign state to 'cxp2'
15:35:06.74   GAME -- Closing state 'cxp2'
15:35:06.75   GAME -- Setting campaign state to 'cxp1'
15:35:06.75   GAME -- Closing state 'cxp1'
15:35:06.75   GAME -- Setting campaign state to 'dlc1'
15:35:06.75   GAME -- Closing state 'dlc1'
15:35:06.76   GAME -- Setting campaign state to 'dlc2'
15:35:06.76   GAME -- Closing state 'dlc2'
15:35:06.76   GAME -- Setting campaign state to 'dlc3'
15:35:06.76   GAME -- Closing state 'dlc3'
15:35:06.77   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:06.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:07.59   Requesting Relic Downloader soft throttle call [GetNewsAsync] has time 812
15:35:07.59   Sent message game CompanyOfHeroes softthrottle
15:35:07.62   Got dlman msg [ack game CompanyOfHeroes softthrottle]
15:35:08.32   GetUserStats requested stats for PIDs ( 3055263 3060096 ) (best:2, full:0)
15:35:08.32   QueryMatches: Got [48] maps, [167] ids, [17] advertisements, startID [1]
15:35:08.32   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 150 matches
15:35:11.59   QueryMatches: Got [48] maps, [167] ids, [17] advertisements, startID [151861601]
15:35:11.59   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 133 matches
15:35:16.56   QueryMatches: Got [49] maps, [164] ids, [17] advertisements, startID [151863149]
15:35:16.56   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 113 matches
15:35:18.00   Transport - Largest sent is now 80
15:35:21.56   QueryMatches: Got [47] maps, [157] ids, [17] advertisements, startID [151863576]
15:35:21.56   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 90 matches
15:35:21.61   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:21.61   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:21.61   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:21.69   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:21.71   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:21.73   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:24.26   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:24.26   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:24.26   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:24.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:24.34   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:24.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:26.48   QueryMatches: Got [47] maps, [154] ids, [17] advertisements, startID [151863873]
15:35:26.49   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 71 matches
15:35:26.76   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:26.76   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:26.76   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:26.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:26.83   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:26.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:28.76   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:28.76   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:28.76   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:28.81   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:28.83   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:28.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:29.15   RNT_ReportPing: user 1868236:HennichHeld CANNOT connect pingMS=65535
15:35:30.01   Transport - median kBPS [hi/cur] sent = 1.1/0.9, recvd = 0.8/0.6, #p/sec[s/r] = 1.9/1.6, max unsent 0, version err 0, merge 0
15:35:30.63   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:30.63   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:30.63   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:30.68   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:30.69   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:30.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:31.52   QueryMatches: Got [50] maps, [162] ids, [17] advertisements, startID [151864033]
15:35:31.53   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 64 matches
15:35:32.39   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:32.39   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:32.39   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:32.46   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:32.47   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:32.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:34.64   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:34.64   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:34.64   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:34.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:34.74   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:34.76   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:36.56   QueryMatches: Got [48] maps, [158] ids, [17] advertisements, startID [151864137]
15:35:36.56   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 47 matches
15:35:37.02   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:37.02   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:37.02   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:37.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:37.10   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:37.13   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:39.28   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:39.28   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:39.28   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:39.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:39.37   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:39.40   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:41.07   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
15:35:41.07   Net::Session::SetVisible - session is set to INVISIBLE.
15:35:41.07   GetMaxFrameTimeFromProfile: players=4 expected FPS=19.146084, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
15:35:41.14   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:41.16   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
15:35:41.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
15:35:41.69   QueryMatches: Got [48] maps, [155] ids, [17] advertisements, startID [151864305]
15:35:41.69   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 34 matches
15:35:46.41   QueryMatches: Got [48] maps, [159] ids, [17] advertisements, startID [151864386]
15:35:46.42   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 21 matches
15:35:48.12   Activating screen: MessageBoxPopup
15:35:48.12   Session is marking the local peer PeerID 1 for death
15:35:48.12   OnlineLeaveAdvertisementAsync: Call to LeaveMatch id = 151864466, cancel = 1, badPids = 0, matchState = 0
15:35:48.12   Session::GetEvent DestroyPeer success Peer 1 removed
15:35:48.12   Session::DestroyPeer - deallocating peer 1
15:35:48.12   Session - Requested Disconnect for connectionID 2
15:35:48.12   Deallocated route ID=3 for PeerID 1 at WINaddr:192.168.0.199:6112;
15:35:48.12   Session - Requested Disconnect for connectionID 3
15:35:48.12   Closed route 3<>3 for PeerID 1 at WINaddr:192.168.0.199:6112;
15:35:48.12   AdvertisementInternal::Process - EVENT_DESTROYPEER
15:35:48.12   LeaveMatchInternal - no action taken, needLeave=0, service=0
15:35:48.12   Destroyed Matchinfo
15:35:48.29   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
15:35:48.29   PeerRemoveAll - flushing local session peer data
15:35:48.29   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
15:35:48.29   Activating screen: FEMovie
15:35:48.29   Activating screen: OnlineWidget
15:35:48.29   Activating screen: FE_mm_01
15:35:48.30   GAME -- Setting campaign state to 'coh'
15:35:48.30   GAME -- Closing state 'coh'
15:35:48.30   GAME -- Setting campaign state to 'cxp2'
15:35:48.31   GAME -- Closing state 'cxp2'
15:35:48.31   GAME -- Setting campaign state to 'cxp1'
15:35:48.31   GAME -- Closing state 'cxp1'
15:35:48.32   GAME -- Setting campaign state to 'dlc1'
15:35:48.32   GAME -- Closing state 'dlc1'
15:35:48.32   GAME -- Setting campaign state to 'dlc2'
15:35:48.32   GAME -- Closing state 'dlc2'
15:35:48.33   GAME -- Setting campaign state to 'dlc3'
15:35:48.33   GAME -- Closing state 'dlc3'
15:35:48.33   MessageInternal::DestroyChannel: Destroyed channel 534d5347
15:35:48.33   GAME -- Setting campaign state to 'coh'
15:35:48.33   GAME -- Closing state 'coh'
15:35:48.34   GAME -- Setting campaign state to 'cxp2'
15:35:48.34   GAME -- Closing state 'cxp2'
15:35:48.34   GAME -- Setting campaign state to 'cxp1'
15:35:48.34   GAME -- Closing state 'cxp1'
15:35:48.35   GAME -- Setting campaign state to 'dlc1'
15:35:48.35   GAME -- Closing state 'dlc1'
15:35:48.35   GAME -- Setting campaign state to 'dlc2'
15:35:48.35   GAME -- Closing state 'dlc2'
15:35:48.35   GAME -- Setting campaign state to 'dlc3'
15:35:48.35   GAME -- Closing state 'dlc3'
15:35:49.19   Activating screen: OptionsMenu
15:35:49.19   THREAD: Hyper-Threading Technology Processors are not detected.
15:35:49.20   THREAD: Hyper-Threading Technology Processors are not detected.
15:35:51.41   QueryMatches: Got [51] maps, [161] ids, [17] advertisements, startID [151864497]
15:35:51.42   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 6 matches
15:35:56.40   QueryMatches: Got [48] maps, [153] ids, [17] advertisements, startID [151864537]
15:35:57.94   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
15:35:57.95   GameApp::ShutFrontEnd
15:35:57.95   GAME -- Ending FE
15:35:57.95   UIFrontEnd - Unloading Front End
15:35:57.97   SOUND -- Shutting down ...
15:35:58.01   SOUND -- Shutdown completed!
15:35:58.04   ~FEAppListener - Flushing queued online notifications
15:35:58.05   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
15:35:58.83   DLLDriverLinker -- 2 DLL drivers found.
15:35:58.83   ActionDatabase : [2343] global actions, [0] dummy actions.
15:35:58.84   NetworkManager::Destroy - destroying network manager
15:35:58.84   RendezvousManager::Shutdown - deleting instance
15:35:58.84   RendezvousManager - terminating all server calls in progress
15:35:58.84   CallManager - terminating all server calls in progress (0 in progress)
15:35:58.84   RendezvousManager - destroying chat handler
15:35:58.84   RendezvousManager::DestroyNATTraversalClient - NAT traversal no longer available.
15:35:58.84   ~RendezvousManager - disconnecting from server
15:35:59.02   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
15:35:59.03   MessageInternal::DestroyChannel: Destroyed channel 50525459
15:35:59.03   PartyInternal: Fade to black
15:35:59.03   AutomatchInternal: Fade to black
15:35:59.03   PeerRemoveAll - flushing local session peer data
15:35:59.03   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
15:35:59.03   MessageInternal::DestroyChannel: Destroyed channel 47535450
15:35:59.03   Session - Requested Disconnect for connectionID 1
15:35:59.03   SessionManager::UnregisterSession - Unregistering session 036f5dd8
15:35:59.03   SessionManager::~SessionManager - uninitializing
15:35:59.03   Net::ThreadFunction - Returning from the network thread function...
15:35:59.04   Transport::~Transport - shutting down transport
15:35:59.05   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
15:35:59.05   Transport::~Connection - closing WINaddr:192.168.0.199:6112;,WINaddr:192.168.0.199:6112;
15:35:59.09   Wrote 567 bytes to network datastore login_cache.bin
15:35:59.10   Wrote 109962 bytes to network datastore global_cache.bin
15:35:59.12   Wrote 2404 bytes to network datastore ping_cache.bin
15:35:59.17   Datastore -- uninitialize complete
15:35:59.17   QuazalInitializer - static uninit of Quazal library
15:35:59.17   QuazalInitializer - unhooking memory 0 currently allocated, 84321 allocations, total of 18587488 bytes
