-- Log file for all dbTracef messages --

19:43:54.12   NetworkManager::Create - creating network manager
19:43:54.12   Read 269 bytes from network datastore login_cache.bin
19:43:54.12   Read 52 bytes from network datastore global_cache.bin
19:43:54.12   Read 46 bytes from network datastore ping_cache.bin
19:43:54.12   QuazalInitializer - static initializing Quazal library
19:43:54.12   PingCache - populating cache with 1 pings
19:43:54.12   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
19:43:54.18   WinTransport - CreateSocket exclusive broadcast socket was available.
19:43:54.18   WinTransport - CreateSocket listening for broadcasts on default port
19:43:54.19   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
19:43:54.19   WinTransport - Host IP Address #0: 7.19.62.180
19:43:54.19   WinTransport - Host IP Address #1: 27.3.16.33
19:43:54.19   WinTransport - Host IP Address #2: 5.162.102.231
19:43:54.19   WinTransport - WARNING, MultipleNetwork adapters may cause problems
19:43:54.19   WinTransport - Interface #0: ip:7.19.62.180, broadcast:7.19.62.180, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
19:43:54.19   WinTransport - Interface #1: ip:5.162.102.231, broadcast:5.162.102.231, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
19:43:54.19   WinTransport - Interface #2: ip:27.3.16.33, broadcast:27.3.16.33, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
19:43:54.19   WinTransport - Interface #3: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
19:43:54.19   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
19:43:54.19   WinTransport - Quazal address string = udp:/address=7.19.62.180;port=6112
19:43:54.19   SessionManager - Peer Header Size = 16 bytes
19:43:54.19   SessionManager - Game Data overhead = 7 bytes
19:43:54.19   SessionManager - Proxy overhead = 7 bytes
19:43:54.19   MessageInternal::CreateChannel: Created channel 47535450
19:43:54.19   Session::Initialize - info, initializing session object, using threads.
19:43:54.19   SessionManager::RegisterSession - Registering new session 04e42e80
19:43:54.19   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
19:43:54.19   AutomatchInternal: Instantiating
19:43:54.19   PartyInternal: Instantiating
19:43:54.19   MessageInternal::CreateChannel: Created channel 50525459
19:43:54.19   MessageInternal::CreateChannel: Created channel 51434b4d
19:43:54.19   Net::ThreadFunction - Entering network thread function...
19:43:54.19   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
19:43:54.19   MessageInternal::CreateChannel: Created channel 534d5347
19:43:54.19   MessageInternal::CreateChannel: Created channel 474d4343
19:43:54.19   MessageInternal::CreateChannel: Created channel 474f424a
19:43:54.19   MessageInternal::CreateChannel: Created channel 4d4f444d
19:43:54.19   MessageInternal::CreateChannel: Created channel 53594e43
19:43:54.19   MessageInternal::DestroyChannel: Destroyed channel 534d5347
19:43:54.19   MessageInternal::DestroyChannel: Destroyed channel 474d4343
19:43:54.19   MessageInternal::DestroyChannel: Destroyed channel 474f424a
19:43:54.19   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
19:43:54.19   MessageInternal::DestroyChannel: Destroyed channel 53594e43
19:43:54.19   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
19:43:54.21   Transport - Largest received is now 19
19:43:54.21   Transport::OpenInternal request to WINaddr:7.19.62.180:6112;
19:43:55.10   DLLDriverLinker -- Adding driver 'spDx10.dll'.
19:43:55.11   DLLDriverLinker -- Adding driver 'spDx9.dll'.
19:43:55.11   DLLDriverLinker -- 2 DLL drivers found.
19:43:55.17   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
19:43:56.88   DLLDriverLinker -- 2 DLL drivers found.
19:43:57.01   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
19:43:57.01   GAME -- Resolution set to 1024x768 (fullscreen).
19:43:57.02   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
19:43:57.02   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
19:43:57.02   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
19:43:57.02   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
19:43:57.52   SPDx9 -- 1774MB available Texture Memory
19:43:57.52   ShaderDatabase: using shader profile [ps30]
19:43:58.15   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
19:43:58.42   GameObjLoader 039cc4c8 - resetting counters
19:43:58.42   GameObjLoader 039cc4c8 - Created loader
19:43:58.42   GameObjLoader 039cc628 - resetting counters
19:43:58.42   GameObjLoader 039cc628 - Created loader
19:43:58.71   GAME -- Beginning FE
19:43:58.71   Sent message game CompanyOfHeroes started 2292 602 allowtraffic
19:43:58.71   RemoteDLManager - Connection Restored.
19:43:58.71   UIFrontEnd - Loading Front End
19:43:58.71   THREAD: Hyper-Threading Technology Processors are not detected.
19:43:58.82   SOUND -- Initializing ...
19:43:58.89   INNIMapDCA Key not found: sp_speechducker::time
19:43:59.50   SOUND -- Initialization completed!
19:43:59.50   UIFrontEnd - Initializing Forms
19:44:00.90   CampaignFilter::BindFilterSpecificWidgets()
19:44:00.97   Activating screen: AppLoadingForm
19:44:00.97   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
19:44:00.97   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
19:44:01.58   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
19:44:01.58   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
19:44:01.58   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
19:44:01.58   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
19:44:01.58   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
19:44:01.58   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
19:44:01.89   GAME -- Using player profile NGOCQUANG-PC
19:44:05.00   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
19:44:05.90   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
19:44:06.59   SPDx9 -- 1752MB available Texture Memory.  Unable to create 516x223 texture.
19:44:06.60   SPDx9 -- 1752MB available Texture Memory.  Unable to create 516x223 texture.
19:44:07.09   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
19:44:07.09   RendezvousManager: CreateSession - starting profile=Guest login
19:44:07.14   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
19:44:07.14   RendezvousManager - unable to connect to the server as guest
19:44:07.16   OnConnect: connect failure
19:44:07.16   RendezvousManager::Shutdown - deleting instance
19:44:07.16   RendezvousManager - terminating all server calls in progress
19:44:07.16   CallManager - terminating all server calls in progress (1 in progress)
19:44:07.16   RendezvousManager - destroying chat handler
19:44:07.16   ~RendezvousManager - m_state = 7, no need for server disconnect
19:44:07.18   OnConnect: this wasnt a reconnect, no need for autologin
19:44:07.19   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
19:44:07.20   CRC & Version Info : 0000025a:db0aab6c:ec3c9e0d blitzkrieg:602:ww2mod.dll 1
19:44:07.20   Activating screen: FEMovie
19:44:07.20   Activating screen: OnlineWidget
19:44:07.20   Activating screen: RelicOnlineLogin
19:44:07.25   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
19:44:07.25   You have a valid version of the game.
19:44:07.27   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
19:44:07.28   installed_products = ( DLC1 DLC2 DLC3 )
19:44:07.28   OnLogin: no previous login, auto selecting profile not required
19:44:07.28   Activating screen: MessageBoxPopup
19:44:07.28   Activating screen: MessageBoxPopup
19:44:07.28   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
19:44:08.53   Beginning media verification...
19:44:08.53   Validator type : validators\udro\udro.dll
19:44:08.53   Activating screen: MessageBoxPopup
19:44:10.72   Activating screen: FE_mm_01
19:44:10.72   GAME -- Setting campaign state to 'dlc1'
19:44:10.72   GAME -- Closing state 'dlc1'
19:44:10.72   GAME -- Setting campaign state to 'dlc2'
19:44:10.72   GAME -- Closing state 'dlc2'
19:44:10.72   GAME -- Setting campaign state to 'dlc3'
19:44:10.72   GAME -- Closing state 'dlc3'
19:44:13.35   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
19:44:13.35   Activating screen: OnlineSelectGame
19:44:13.37   Activating screen: RelicOnlineChat
19:44:13.37   Activating screen: RelicOnlineNewsScreen
19:44:13.37   Activating screen: RelicOnlineStatsScreen
19:44:13.37   Activating screen: Achievements
19:44:13.37   GAME -- Setting campaign state to 'dlc1'
19:44:13.37   GAME -- Closing state 'dlc1'
19:44:13.37   GAME -- Setting campaign state to 'dlc2'
19:44:13.37   GAME -- Closing state 'dlc2'
19:44:13.37   GAME -- Setting campaign state to 'dlc3'
19:44:13.37   GAME -- Closing state 'dlc3'
19:44:13.38   Activating screen: GameHistory
19:44:13.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:13.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:13.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:13.38   Activating screen: OnlineSelectGame
19:44:13.38   Activating screen: RelicOnlineTabs
19:44:13.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:13.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:13.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:25.93   Transport::OpenInternal request to WINaddr:7.8.234.24:6112;
19:44:25.93   Transport - Largest sent is now 30
19:44:26.19   Transport::OpenInternal request to WINaddr:7.9.77.214:6112;
19:44:26.33   Transport - Largest received is now 30
19:44:27.07   Transport::OpenInternal request to WINaddr:7.10.231.191:6112;
19:44:27.20   Transport::OpenInternal request to WINaddr:7.4.139.72:6112;
19:44:27.28   Transport::OpenInternal request to WINaddr:7.15.190.172:6112;
19:44:27.32   Transport::OpenInternal request to WINaddr:7.6.29.234:6112;
19:44:29.27   CancelAutoMatching - called
19:44:29.27   Activating screen: OnlineSelectGame
19:44:29.27   Activating screen: RelicOnlineTabs
19:44:29.27   Activating screen: FEMovie
19:44:29.27   Activating screen: OnlineWidget
19:44:29.27   Activating screen: FE_mm_01
19:44:29.27   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:29.27   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:29.27   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:44:29.28   GAME -- Setting campaign state to 'dlc1'
19:44:29.28   GAME -- Closing state 'dlc1'
19:44:29.28   GAME -- Setting campaign state to 'dlc2'
19:44:29.28   GAME -- Closing state 'dlc2'
19:44:29.28   GAME -- Setting campaign state to 'dlc3'
19:44:29.28   GAME -- Closing state 'dlc3'
19:44:55.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.1/0.0, #p/sec[s/r] = 0.8/0.9, max unsent 0, version err 0, merge 6
19:45:36.78   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
19:45:36.78   Activating screen: OnlineSelectGame
19:45:36.79   Activating screen: RelicOnlineChat
19:45:36.79   Activating screen: RelicOnlineNewsScreen
19:45:36.79   Activating screen: RelicOnlineStatsScreen
19:45:36.79   Activating screen: Achievements
19:45:36.79   GAME -- Setting campaign state to 'dlc1'
19:45:36.79   GAME -- Closing state 'dlc1'
19:45:36.79   GAME -- Setting campaign state to 'dlc2'
19:45:36.79   GAME -- Closing state 'dlc2'
19:45:36.79   GAME -- Setting campaign state to 'dlc3'
19:45:36.79   GAME -- Closing state 'dlc3'
19:45:36.80   Activating screen: GameHistory
19:45:36.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:45:36.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:45:36.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:45:36.80   Activating screen: OnlineSelectGame
19:45:36.80   Activating screen: RelicOnlineTabs
19:45:38.00   Transport - Largest received is now 477
19:45:39.78   JoinAsync: Starting AsyncJob...
19:45:39.78   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
19:45:39.78   Created Matchinfo
19:45:39.80   Activating screen: MessageBoxPopup
19:45:39.84   OnlineJoinAsync success
19:45:39.84   OnJoinAdvertisementSuccess - joined online match, server leave notification required
19:45:39.86   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
19:45:39.86   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
19:45:39.86   Allocated route ID=0 for PeerID 0 at WINaddr:7.19.62.180:6112;
19:45:39.86   Transport::OpenInternal request to WINaddr:7.19.62.180:6112;
19:45:39.86   Allocated route ID=0 for PeerID 0 at WINaddr:7.4.139.72:6112;
19:45:39.86   Transport::OpenInternal request to WINaddr:7.4.139.72:6112;
19:45:39.86   Session::Connect sid = 3361DBA8ED6FC3DD, hostURL = WINaddr:7.4.139.72:6112;, local addresses = WINaddr:7.19.62.180:6112;
19:45:39.88   Transport - Largest sent is now 192
19:45:39.88   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
19:45:40.61   Transport - Largest received is now 746
19:45:40.93   Transport - Largest received is now 1331
19:45:40.94   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the local peer
19:45:40.94   Session - highest peerID now : 2
19:45:40.94   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the host
19:45:40.97   ValidateCustomData: called with 210 bytes of custom data
19:45:40.97   Client accepted Peer 2 into the match at address list = WINaddr:7.19.62.180:6112;, routes = WINaddr:7.19.62.180:6112;
19:45:40.97   Session::GetEvent - probing service provided NAT'd routes
19:45:40.97   AdvertisementInternal::Process - EVENT_NEWPEER
19:45:40.97   ValidateCustomData: called with 694 bytes of custom data
19:45:40.97   Client accepted Peer 1 into the match at address list = WINaddr:7.4.139.72:6112;, routes = WINaddr:7.4.139.72:6112;
19:45:40.97   AdvertisementInternal::Process - EVENT_NEWPEER
19:45:40.97   Accepted matchInfo updated 36 from host
19:45:40.97   Accepted matchInfo updated 38 from host
19:45:40.99   JoinAsync - got operation info 0:SessionOperationInfo::SUCCESS
19:45:41.00   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
19:45:41.00   local      PeerID 2 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:7.19.62.180:6112; (ping=0ms) 100.00%, pending=0, dead=0
19:45:41.00         host PeerID 1 CONN ack=  0 (  0ms~0) unack=  4, retry=  0, highwaterOOS=0 @WINaddr:7.4.139.72:6112; (ping=959ms) 100.00%, pending=0, dead=0
19:45:41.00   MessageCounts: inval=0/0, seek=0/0, join=1/0, integ=0/0, seek_reply=0/1, join_reply=0/0, add=0/2, remove=0/0, drop=0/0, data=2/2, voice=0/0, rchk=1/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=1/1, frag=0/2, Errors=0/0
19:45:41.01   JoinAsync - completed with JoinResult = 0:JoinEvent::R_Success
19:45:41.01   Activating screen: OnlineGameSetup
19:45:41.01   Activating screen: RelicOnlineTabs
19:45:41.01   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
19:45:41.01   JoinAsync: AsyncJob Complete...
19:45:41.03   MessageInternal::CreateChannel: Created channel 534d5347
19:45:41.03   Map stonewall_boucamps does not have a valid operation type
19:45:41.03   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:45:41.03   Activating screen: ScreenTipPopup
19:45:41.04   Transport - Largest sent is now 331
19:45:41.93   Accepted matchInfo updated 39 from host
19:45:42.75   Accepted matchInfo updated 41 from host
19:45:42.76   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:45:42.78   Transport - Largest sent is now 338
19:45:42.98   Accepted matchInfo updated 43 from host
19:45:44.00   Transport - Largest sent is now 369
19:45:44.21   Accepted matchInfo updated 44 from host
19:45:44.25   Accepted matchInfo updated 46 from host
19:45:56.00   Transport - median kBPS [hi/cur] sent = 0.5/0.0, recvd = 4.1/0.1, #p/sec[s/r] = 2.0/2.3, max unsent 0, version err 0, merge 10
19:46:42.00   local      PeerID 2 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:7.19.62.180:6112; (ping=0ms) 100.00%, pending=0, dead=0
19:46:42.00         host PeerID 1 CONN ack=  0 (467ms~0) unack=  0, retry=  6, highwaterOOS=0 @WINaddr:7.4.139.72:6112; (ping=396ms) 75.00%, pending=0, dead=0
19:46:42.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/2, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=14/12, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=106/105, frag=0/6, Errors=0/0
19:46:57.00   Transport - median kBPS [hi/cur] sent = 0.5/0.0, recvd = 4.1/0.0, #p/sec[s/r] = 1.9/2.4, max unsent 0, version err 0, merge 0
19:47:11.48   Transport::OpenInternal request to WINaddr:7.11.55.164:6112;
19:47:43.01   local      PeerID 2 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:7.19.62.180:6112; (ping=0ms) 100.00%, pending=0, dead=0
19:47:43.01         host PeerID 1 CONN ack=  0 (707ms~0) unack=  0, retry=  7, highwaterOOS=0 @WINaddr:7.4.139.72:6112; (ping=424ms) 73.08%, pending=0, dead=0
19:47:43.01   MessageCounts: inval=0/0, seek=0/8, join=0/0, integ=0/0, seek_reply=0/6, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=1/3, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=98/98, frag=0/13, Errors=0/0
19:47:58.01   Transport - median kBPS [hi/cur] sent = 0.5/0.2, recvd = 4.1/0.3, #p/sec[s/r] = 2.1/3.0, max unsent 0, version err 0, merge 1
19:48:24.37   Session::PollTransportEvents AddPeerMessage from peer 1 recv'd for unknown peer at address list WINaddr:7.11.55.164:6112;
19:48:24.37   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
19:48:24.37   Session::CheckAddress - initiating address check for WINaddr:7.11.55.164:6112;
19:48:24.37   Session - highest peerID now : 3
19:48:24.38   ValidateCustomData: called with 174 bytes of custom data
19:48:24.38   Client accepted Peer 3 into the match at address list = WINaddr:7.11.55.164:6112;, routes =
19:48:24.38   AdvertisementInternal::Process - EVENT_NEWPEER
19:48:24.38   Accepted matchInfo updated 47 from host
19:48:24.39   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:48:24.39   Transport - Largest sent is now 428
19:48:24.46   Accepted matchInfo updated 49 from host
19:48:25.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:48:25.13   Session::PeerIntroduction - Got routecheck for existing Peer 3, from address WINaddr:7.11.55.164:6112;
19:48:25.13   Allocated route ID=0 for PeerID 3 at WINaddr:7.11.55.164:6112;
19:48:25.13   Transport::OpenInternal request to WINaddr:7.11.55.164:6112;
19:48:25.13   Session::CheckAddressSuccess - peer located at address WINaddr:7.11.55.164:6112;
19:48:25.13   Peer::AcceptRoute - route 7<>0 pending accept @ WINaddr:7.11.55.164:6112; for peerID:3
19:48:25.13   Session::ProcessPeerIntroductionMessages sending RouteCheck response #1 to Peer 3 @ WINaddr:7.11.55.164:6112;
19:48:25.49   Session::PeerIntroduction - Got routecheck for existing Peer 3, from address WINaddr:7.11.55.164:6112;
19:48:25.49   Peer::AcceptRoute - accepted route 7<>7 WINaddr:7.11.55.164:6112; for peerID:3
19:48:25.49   Session::ProcessPeerIntroductionMessages sending RouteCheck response #2 to Peer 3 @ WINaddr:7.11.55.164:6112;
19:48:26.18   Accepted matchInfo updated 51 from host
19:48:26.19   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:48:26.21   Accepted matchInfo updated 53 from host
19:48:26.28   Accepted matchInfo updated 57 from host
19:48:27.88   Accepted matchInfo updated 60 from host
19:48:28.00   Accepted matchInfo updated 63 from host
19:48:44.01   local      PeerID 2 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:7.19.62.180:6112; (ping=0ms) 100.00%, pending=0, dead=0
19:48:44.01         host PeerID 1 CONN ack=  0 (444ms~0) unack=  0, retry= 30, highwaterOOS=0 @WINaddr:7.4.139.72:6112; (ping=414ms) 57.75%, pending=0, dead=0
19:48:44.01              PeerID 3 CONN ack=  0 (464ms~0) unack=  0, retry=  1, highwaterOOS=0 @WINaddr:7.11.55.164:6112; (ping=429ms) 75.00%, pending=0, dead=0
19:48:44.01   MessageCounts: inval=0/0, seek=0/9, join=0/0, integ=0/0, seek_reply=0/10, join_reply=0/0, add=0/1, remove=0/0, drop=0/0, data=23/16, voice=0/0, rchk=3/2, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=123/119, frag=0/20, Errors=0/0
19:48:59.01   Transport - median kBPS [hi/cur] sent = 0.9/0.0, recvd = 4.1/0.0, #p/sec[s/r] = 2.5/3.2, max unsent 0, version err 0, merge 17
19:49:45.00   local      PeerID 2 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:7.19.62.180:6112; (ping=0ms) 100.00%, pending=0, dead=0
19:49:45.00         host PeerID 1 CONN ack=  0 (454ms~0) unack=  0, retry= 30, highwaterOOS=0 @WINaddr:7.4.139.72:6112; (ping=397ms) 60.53%, pending=0, dead=0
19:49:45.00              PeerID 3 CONN ack=  0 (494ms~0) unack=  0, retry=  1, highwaterOOS=0 @WINaddr:7.11.55.164:6112; (ping=426ms) 88.89%, pending=0, dead=0
19:49:45.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=10/9, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=107/107, frag=0/0, Errors=0/0
19:50:00.00   Transport - median kBPS [hi/cur] sent = 0.9/0.1, recvd = 4.1/0.1, #p/sec[s/r] = 2.4/2.9, max unsent 0, version err 0, merge 0
19:50:31.74   Session::ProcessPeerMessages LocalPeer is marking PeerID 3 for death on instruction from Host
19:50:31.76   Session::GetEvent DestroyPeer success Peer 3 removed
19:50:31.76   Session::DestroyPeer - deallocating peer 3
19:50:31.76   Session - Requested Disconnect for connectionID 6
19:50:31.76   Deallocated route ID=7 for PeerID 3 at WINaddr:7.11.55.164:6112;
19:50:31.76   Session - Requested Disconnect for connectionID 7
19:50:31.76   Closed route 7<>7 for PeerID 3 at WINaddr:7.11.55.164:6112;
19:50:31.76   AdvertisementInternal::Process - EVENT_DESTROYPEER
19:50:32.60   Accepted matchInfo updated 64 from host
19:50:32.61   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:50:33.59   Accepted matchInfo updated 66 from host
19:50:34.19   Accepted matchInfo updated 69 from host
19:50:40.96   Session::PollTransportEvents AddPeerMessage from peer 1 recv'd for unknown peer at address list WINaddr:7.11.55.164:6112;
19:50:40.96   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
19:50:40.96   Session::CheckAddress - initiating address check for WINaddr:7.11.55.164:6112;
19:50:40.96   Session - highest peerID now : 4
19:50:40.96   ValidateCustomData: called with 174 bytes of custom data
19:50:40.96   Client accepted Peer 4 into the match at address list = WINaddr:7.11.55.164:6112;, routes =
19:50:40.96   AdvertisementInternal::Process - EVENT_NEWPEER
19:50:40.96   Accepted matchInfo updated 70 from host
19:50:40.97   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:50:41.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:41.07   Accepted matchInfo updated 72 from host
19:50:41.14   Session::PeerIntroduction - Got routecheck for existing Peer 4, from address WINaddr:7.11.55.164:6112;
19:50:41.14   Allocated route ID=0 for PeerID 4 at WINaddr:7.11.55.164:6112;
19:50:41.14   Transport::OpenInternal request to WINaddr:7.11.55.164:6112;
19:50:41.14   Session::CheckAddressSuccess - peer located at address WINaddr:7.11.55.164:6112;
19:50:41.14   Peer::AcceptRoute - route 9<>0 pending accept @ WINaddr:7.11.55.164:6112; for peerID:4
19:50:41.14   Session::ProcessPeerIntroductionMessages sending RouteCheck response #1 to Peer 4 @ WINaddr:7.11.55.164:6112;
19:50:41.48   Session::PeerIntroduction - Got routecheck for existing Peer 4, from address WINaddr:7.11.55.164:6112;
19:50:41.48   Peer::AcceptRoute - accepted route 9<>13 WINaddr:7.11.55.164:6112; for peerID:4
19:50:41.48   Session::ProcessPeerIntroductionMessages sending RouteCheck response #2 to Peer 4 @ WINaddr:7.11.55.164:6112;
19:50:43.52   Session::ProcessPeerMessages ignoring INTEGRITYCHECK from peer 4, because we're not the host (hostPeerID=1)
19:50:43.54   Closed route 9<>13 by remote request for PeerID 4 at WINaddr:7.11.55.164:6112;
19:50:43.54   Session::ProcessPeerMessages Session Host is marking PeerID 4 for death by dropout request
19:50:43.55   Session::GetEvent DestroyPeer success Peer 4 removed
19:50:43.55   Session::DestroyPeer - deallocating peer 4
19:50:43.55   Session - Requested Disconnect for connectionID 8
19:50:43.55   Deallocated route ID=9 for PeerID 4 at WINaddr:7.11.55.164:6112;
19:50:43.55   Session - Requested Disconnect for connectionID 9
19:50:43.55   Closed route 9<>13 for PeerID 4 at WINaddr:7.11.55.164:6112;
19:50:43.55   AdvertisementInternal::Process - EVENT_DESTROYPEER
19:50:43.74   Accepted matchInfo updated 74 from host
19:50:43.74   Accepted matchInfo updated 76 from host
19:50:43.75   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:50:43.76   Transport - Largest sent is now 451
19:50:43.94   Session::ProcessPeerMessages Message::REMOVEPEER ignored peer already removed
19:50:43.94   Session::PollTransportEvents AddPeerMessage from peer 1 recv'd for unknown peer at address list WINaddr:7.11.55.164:6112;
19:50:43.94   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
19:50:43.94   Session::CheckAddress - initiating address check for WINaddr:7.11.55.164:6112;
19:50:43.94   Session - highest peerID now : 5
19:50:43.94   Accepted matchInfo updated 79 from host
19:50:43.94   Accepted matchInfo updated 80 from host
19:50:43.94   Accepted matchInfo updated 82 from host
19:50:43.94   ValidateCustomData: called with 174 bytes of custom data
19:50:43.94   Client accepted Peer 5 into the match at address list = WINaddr:7.11.55.164:6112;, routes =
19:50:43.94   AdvertisementInternal::Process - EVENT_NEWPEER
19:50:43.94   Accepted matchInfo updated 83 from host
19:50:43.94   Accepted matchInfo updated 85 from host
19:50:43.95   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:50:43.96   Transport - Largest sent is now 574
19:50:44.00   Session::ProcessPeerMessages LocalPeer is marking PeerID 5 for death on instruction from Host
19:50:44.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:44.02   Session::GetEvent DestroyPeer success Peer 5 removed
19:50:44.02   Session::DestroyPeer - deallocating peer 5
19:50:44.02   Session - Requested Disconnect for connectionID 10
19:50:44.02   AdvertisementInternal::Process - EVENT_DESTROYPEER
19:50:44.85   Accepted matchInfo updated 86 from host
19:50:44.86   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261767, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
19:50:44.89   Accepted matchInfo updated 88 from host
19:50:45.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:45.75   Accepted matchInfo updated 91 from host
19:50:45.93   Accepted matchInfo updated 94 from host
19:50:46.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:46.00   local      PeerID 2 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:7.19.62.180:6112; (ping=0ms) 100.00%, pending=0, dead=0
19:50:46.00         host PeerID 1 CONN ack=  0 (1786ms~0) unack=  7, retry= 84, highwaterOOS=7 @WINaddr:7.4.139.72:6112; (ping=402ms) 49.40%, pending=0, dead=0
19:50:46.00   MessageCounts: inval=0/0, seek=0/2, join=0/0, integ=0/1, seek_reply=0/5, join_reply=0/0, add=0/2, remove=1/3, drop=0/1, data=38/25, voice=0/0, rchk=6/2, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=116/124, frag=0/12, Errors=0/0
19:50:46.71   Accepted matchInfo updated 97 from host
19:50:47.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:48.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:49.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:50.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:51.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:52.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:53.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:54.00   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.55.164:6112;
19:50:54.00   Session::ProcessCheckAddressList - address WINaddr:7.11.55.164:6112; timed out
19:51:01.00   Transport - median kBPS [hi/cur] sent = 1.5/0.1, recvd = 7.6/0.6, #p/sec[s/r] = 3.2/4.2, max unsent 0, version err 0, merge 57
19:51:18.18   Accepted matchInfo updated 98 from host
19:51:46.04   Activating screen: MessageBoxPopup
19:51:46.04   Session is marking PeerID 1 for death
19:51:46.04   Session is marking the local peer PeerID 2 for death
19:51:46.04   Session::GetEvent DestroyPeer success Peer 1 removed
19:51:46.04   Session::DestroyPeer - deallocating peer 1
19:51:46.04   Session - Requested Disconnect for connectionID 3
19:51:46.04   Deallocated route ID=5 for PeerID 1 at WINaddr:7.4.139.72:6112;
19:51:46.04   Session - Requested Disconnect for connectionID 5
19:51:46.04   Closed route 5<>7 for PeerID 1 at WINaddr:7.4.139.72:6112;
19:51:46.04   AdvertisementInternal::Process - EVENT_DESTROYPEER
19:51:46.04   Session::GetEvent DestroyPeer success Peer 2 removed
19:51:46.04   Session::DestroyPeer - deallocating peer 2
19:51:46.04   Session - Requested Disconnect for connectionID 2
19:51:46.04   Deallocated route ID=4 for PeerID 2 at WINaddr:7.19.62.180:6112;
19:51:46.04   Session - Requested Disconnect for connectionID 4
19:51:46.04   Closed route 4<>4 for PeerID 2 at WINaddr:7.19.62.180:6112;
19:51:46.04   AdvertisementInternal::Process - EVENT_DESTROYPEER
19:51:46.04   Destroyed Matchinfo
19:51:46.05   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
19:51:46.05   PeerRemoveAll - flushing local session peer data
19:51:46.05   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
19:51:46.06   Activating screen: OnlineSelectGame
19:51:46.06   Activating screen: RelicOnlineTabs
19:51:46.08   MessageInternal::DestroyChannel: Destroyed channel 534d5347
19:52:02.01   Transport - median kBPS [hi/cur] sent = 1.5/0.0, recvd = 7.6/0.0, #p/sec[s/r] = 2.1/2.3, max unsent 0, version err 0, merge 0
19:52:06.24   CancelAutoMatching - called
19:52:06.24   Activating screen: OnlineSelectGame
19:52:06.24   Activating screen: RelicOnlineTabs
19:52:06.24   Activating screen: FEMovie
19:52:06.24   Activating screen: OnlineWidget
19:52:06.24   Activating screen: FE_mm_01
19:52:06.24   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:06.24   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:06.24   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:06.25   GAME -- Setting campaign state to 'dlc1'
19:52:06.25   GAME -- Closing state 'dlc1'
19:52:06.25   GAME -- Setting campaign state to 'dlc2'
19:52:06.25   GAME -- Closing state 'dlc2'
19:52:06.25   GAME -- Setting campaign state to 'dlc3'
19:52:06.25   GAME -- Closing state 'dlc3'
19:52:07.30   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
19:52:07.30   Activating screen: OnlineSelectGame
19:52:07.31   Activating screen: RelicOnlineChat
19:52:07.31   Activating screen: RelicOnlineNewsScreen
19:52:07.31   Activating screen: RelicOnlineStatsScreen
19:52:07.31   Activating screen: Achievements
19:52:07.31   GAME -- Setting campaign state to 'dlc1'
19:52:07.31   GAME -- Closing state 'dlc1'
19:52:07.31   GAME -- Setting campaign state to 'dlc2'
19:52:07.31   GAME -- Closing state 'dlc2'
19:52:07.31   GAME -- Setting campaign state to 'dlc3'
19:52:07.31   GAME -- Closing state 'dlc3'
19:52:07.32   Activating screen: GameHistory
19:52:07.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:07.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:07.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:07.32   Activating screen: OnlineSelectGame
19:52:07.32   Activating screen: RelicOnlineTabs
19:52:09.37   CancelAutoMatching - called
19:52:09.37   Activating screen: OnlineSelectGame
19:52:09.37   Activating screen: RelicOnlineTabs
19:52:09.37   Activating screen: FEMovie
19:52:09.37   Activating screen: OnlineWidget
19:52:09.37   Activating screen: FE_mm_01
19:52:09.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:09.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:09.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:09.38   GAME -- Setting campaign state to 'dlc1'
19:52:09.38   GAME -- Closing state 'dlc1'
19:52:09.38   GAME -- Setting campaign state to 'dlc2'
19:52:09.38   GAME -- Closing state 'dlc2'
19:52:09.38   GAME -- Setting campaign state to 'dlc3'
19:52:09.38   GAME -- Closing state 'dlc3'
19:52:10.84   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
19:52:10.84   Activating screen: OnlineSelectGame
19:52:10.84   Activating screen: RelicOnlineChat
19:52:10.84   Activating screen: RelicOnlineNewsScreen
19:52:10.84   Activating screen: RelicOnlineStatsScreen
19:52:10.84   Activating screen: Achievements
19:52:10.84   GAME -- Setting campaign state to 'dlc1'
19:52:10.84   GAME -- Closing state 'dlc1'
19:52:10.84   GAME -- Setting campaign state to 'dlc2'
19:52:10.84   GAME -- Closing state 'dlc2'
19:52:10.85   GAME -- Setting campaign state to 'dlc3'
19:52:10.85   GAME -- Closing state 'dlc3'
19:52:10.85   Activating screen: GameHistory
19:52:10.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:10.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:10.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:10.85   Activating screen: OnlineSelectGame
19:52:10.85   Activating screen: RelicOnlineTabs
19:52:16.56   CancelAutoMatching - called
19:52:16.56   Activating screen: OnlineSelectGame
19:52:16.56   Activating screen: RelicOnlineTabs
19:52:16.56   Activating screen: FEMovie
19:52:16.56   Activating screen: OnlineWidget
19:52:16.56   Activating screen: FE_mm_01
19:52:16.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:16.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:16.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
19:52:16.56   GAME -- Setting campaign state to 'dlc1'
19:52:16.56   GAME -- Closing state 'dlc1'
19:52:16.57   GAME -- Setting campaign state to 'dlc2'
19:52:16.57   GAME -- Closing state 'dlc2'
19:52:16.57   GAME -- Setting campaign state to 'dlc3'
19:52:16.57   GAME -- Closing state 'dlc3'
19:52:18.34   Activating screen: QuitPromptDialog
19:52:19.29   GameApp::Quit( exitValue = 0 )
19:52:19.31   GameApp::ShutFrontEnd
19:52:19.32   GAME -- Ending FE
19:52:19.32   UIFrontEnd - Unloading Front End
19:52:19.34   SOUND -- Shutting down ...
19:52:19.39   SOUND -- Shutdown completed!
19:52:19.43   ~FEAppListener - Flushing queued online notifications
19:52:19.55   DLLDriverLinker -- 2 DLL drivers found.
19:52:19.55   ActionDatabase : [2348] global actions, [0] dummy actions.
19:52:19.55   NetworkManager::Destroy - destroying network manager
19:52:19.55   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
19:52:19.55   MessageInternal::DestroyChannel: Destroyed channel 50525459
19:52:19.55   PartyInternal: Fade to black
19:52:19.55   AutomatchInternal: Fade to black
19:52:19.55   PeerRemoveAll - flushing local session peer data
19:52:19.55   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
19:52:19.55   MessageInternal::DestroyChannel: Destroyed channel 47535450
19:52:19.55   Session - Requested Disconnect for connectionID 1
19:52:19.55   SessionManager::UnregisterSession - Unregistering session 04e42e80
19:52:19.55   SessionManager::~SessionManager - uninitializing
19:52:19.56   Net::ThreadFunction - Returning from the network thread function...
19:52:19.56   Transport::~Transport - shutting down transport
19:52:19.56   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.19.62.180:6112;,WINaddr:7.19.62.180:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.8.234.24:6112;,WINaddr:7.8.234.24:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.9.77.214:6112;,WINaddr:7.9.77.214:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.10.231.191:6112;,WINaddr:7.10.231.191:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.4.139.72:6112;,WINaddr:7.4.139.72:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.15.190.172:6112;,WINaddr:7.15.190.172:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.6.29.234:6112;,WINaddr:7.6.29.234:6112;
19:52:19.56   Transport::~Connection - closing WINaddr:7.11.55.164:6112;,WINaddr:7.11.55.164:6112;
19:52:19.56   Wrote 269 bytes to network datastore login_cache.bin
19:52:19.56   Wrote 52 bytes to network datastore global_cache.bin
19:52:19.56   Wrote 46 bytes to network datastore ping_cache.bin
19:52:19.56   Datastore -- uninitialize complete
19:52:19.56   QuazalInitializer - static uninit of Quazal library
19:52:19.56   QuazalInitializer - unhooking memory 0 currently allocated, 250 allocations, total of 24108 bytes
