-- Log file for all dbTracef messages --

18:17:46.21   NetworkManager::Create - creating network manager
18:17:46.21   Read 269 bytes from network datastore login_cache.bin
18:17:46.21   Read 52 bytes from network datastore global_cache.bin
18:17:46.21   Read 28 bytes from network datastore ping_cache.bin
18:17:46.21   QuazalInitializer - static initializing Quazal library
18:17:46.21   PingCache - populating cache with 0 pings
18:17:46.21   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
18:17:46.26   WinTransport - CreateSocket exclusive broadcast socket was available.
18:17:46.26   WinTransport - CreateSocket listening for broadcasts on default port
18:17:46.27   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
18:17:46.27   WinTransport - Host IP Address #0: 7.19.62.180
18:17:46.27   WinTransport - Host IP Address #1: 5.162.102.231
18:17:46.27   WinTransport - WARNING, MultipleNetwork adapters may cause problems
18:17:46.27   WinTransport - Interface #0: ip:7.19.62.180, broadcast:7.19.62.180, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
18:17:46.27   WinTransport - Interface #1: ip:5.162.102.231, broadcast:5.162.102.231, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
18:17:46.27   WinTransport - Interface #2: ip:27.3.16.33, broadcast:27.3.16.33, flags=IFF_BROADCAST IFF_MULTICAST
18:17:46.27   WinTransport - Interface #3: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
18:17:46.27   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:17:46.27   WinTransport - Quazal address string = udp:/address=7.19.62.180;port=6112
18:17:46.27   SessionManager - Peer Header Size = 16 bytes
18:17:46.27   SessionManager - Game Data overhead = 7 bytes
18:17:46.27   SessionManager - Proxy overhead = 7 bytes
18:17:46.27   MessageInternal::CreateChannel: Created channel 47535450
18:17:46.27   Session::Initialize - info, initializing session object, using threads.
18:17:46.27   SessionManager::RegisterSession - Registering new session 07262e40
18:17:46.27   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:17:46.27   AutomatchInternal: Instantiating
18:17:46.27   PartyInternal: Instantiating
18:17:46.27   MessageInternal::CreateChannel: Created channel 50525459
18:17:46.27   MessageInternal::CreateChannel: Created channel 51434b4d
18:17:46.27   Net::ThreadFunction - Entering network thread function...
18:17:46.27   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
18:17:46.27   MessageInternal::CreateChannel: Created channel 534d5347
18:17:46.27   MessageInternal::CreateChannel: Created channel 474d4343
18:17:46.27   MessageInternal::CreateChannel: Created channel 474f424a
18:17:46.27   MessageInternal::CreateChannel: Created channel 4d4f444d
18:17:46.27   MessageInternal::CreateChannel: Created channel 53594e43
18:17:46.27   MessageInternal::DestroyChannel: Destroyed channel 534d5347
18:17:46.27   MessageInternal::DestroyChannel: Destroyed channel 474d4343
18:17:46.27   MessageInternal::DestroyChannel: Destroyed channel 474f424a
18:17:46.27   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
18:17:46.27   MessageInternal::DestroyChannel: Destroyed channel 53594e43
18:17:46.27   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
18:17:46.29   Transport - Largest received is now 19
18:17:46.29   Transport::OpenInternal request to WINaddr:7.19.62.180:6112;
18:17:47.18   DLLDriverLinker -- Adding driver 'spDx10.dll'.
18:17:47.19   DLLDriverLinker -- Adding driver 'spDx9.dll'.
18:17:47.19   DLLDriverLinker -- 2 DLL drivers found.
18:17:47.25   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
18:17:48.92   DLLDriverLinker -- 2 DLL drivers found.
18:17:49.05   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
18:17:49.05   GAME -- Resolution set to 1024x768 (fullscreen).
18:17:49.07   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
18:17:49.07   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
18:17:49.07   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
18:17:49.07   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
18:17:49.56   SPDx9 -- 1774MB available Texture Memory
18:17:49.56   ShaderDatabase: using shader profile [ps30]
18:17:50.17   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
18:17:50.46   GameObjLoader 09eaadc0 - resetting counters
18:17:50.46   GameObjLoader 09eaadc0 - Created loader
18:17:50.46   GameObjLoader 09eaaf20 - resetting counters
18:17:50.46   GameObjLoader 09eaaf20 - Created loader
18:17:50.75   GAME -- Beginning FE
18:17:50.75   Sent message game CompanyOfHeroes started 2904 602 allowtraffic
18:17:50.75   RemoteDLManager - Connection Restored.
18:17:50.75   UIFrontEnd - Loading Front End
18:17:50.75   THREAD: Hyper-Threading Technology Processors are not detected.
18:17:50.85   SOUND -- Initializing ...
18:17:50.92   INNIMapDCA Key not found: sp_speechducker::time
18:17:51.55   SOUND -- Initialization completed!
18:17:51.55   UIFrontEnd - Initializing Forms
18:17:52.96   CampaignFilter::BindFilterSpecificWidgets()
18:17:53.04   Activating screen: AppLoadingForm
18:17:53.04   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
18:17:53.04   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
18:17:53.80   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
18:17:53.80   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
18:17:53.80   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
18:17:53.80   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
18:17:53.80   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
18:17:53.80   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
18:17:54.13   GAME -- Using player profile NGOCQUANG-PC
18:17:57.31   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
18:17:58.24   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
18:17:58.98   SPDx9 -- 1752MB available Texture Memory.  Unable to create 516x223 texture.
18:17:59.09   SPDx9 -- 1752MB available Texture Memory.  Unable to create 516x223 texture.
18:18:00.61   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
18:18:00.61   RendezvousManager: CreateSession - starting profile=Guest login
18:18:00.66   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
18:18:00.66   RendezvousManager - unable to connect to the server as guest
18:18:00.68   OnConnect: connect failure
18:18:00.68   RendezvousManager::Shutdown - deleting instance
18:18:00.68   RendezvousManager - terminating all server calls in progress
18:18:00.68   CallManager - terminating all server calls in progress (1 in progress)
18:18:00.68   RendezvousManager - destroying chat handler
18:18:00.68   ~RendezvousManager - m_state = 7, no need for server disconnect
18:18:00.70   OnConnect: this wasnt a reconnect, no need for autologin
18:18:00.71   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
18:18:00.72   CRC & Version Info : 0000025a:db0aab6c:ec3c9e0d blitzkrieg:602:ww2mod.dll 1
18:18:00.72   Activating screen: FEMovie
18:18:00.72   Activating screen: OnlineWidget
18:18:00.72   Activating screen: RelicOnlineLogin
18:18:00.75   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
18:18:00.75   You have a valid version of the game.
18:18:00.78   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
18:18:00.78   installed_products = ( DLC1 DLC2 DLC3 )
18:18:00.78   OnLogin: no previous login, auto selecting profile not required
18:18:00.78   Activating screen: MessageBoxPopup
18:18:00.78   Activating screen: MessageBoxPopup
18:18:00.78   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
18:18:02.25   Beginning media verification...
18:18:02.25   Validator type : validators\udro\udro.dll
18:18:02.25   Activating screen: MessageBoxPopup
18:18:04.37   Activating screen: FE_mm_01
18:18:04.37   GAME -- Setting campaign state to 'dlc1'
18:18:04.37   GAME -- Closing state 'dlc1'
18:18:04.37   GAME -- Setting campaign state to 'dlc2'
18:18:04.37   GAME -- Closing state 'dlc2'
18:18:04.38   GAME -- Setting campaign state to 'dlc3'
18:18:04.38   GAME -- Closing state 'dlc3'
18:18:06.64   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
18:18:06.64   Activating screen: OnlineSelectGame
18:18:06.65   Activating screen: RelicOnlineChat
18:18:06.65   Activating screen: RelicOnlineNewsScreen
18:18:06.65   Activating screen: RelicOnlineStatsScreen
18:18:06.65   Activating screen: Achievements
18:18:06.65   GAME -- Setting campaign state to 'dlc1'
18:18:06.65   GAME -- Closing state 'dlc1'
18:18:06.66   GAME -- Setting campaign state to 'dlc2'
18:18:06.66   GAME -- Closing state 'dlc2'
18:18:06.66   GAME -- Setting campaign state to 'dlc3'
18:18:06.66   GAME -- Closing state 'dlc3'
18:18:06.66   Activating screen: GameHistory
18:18:06.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:06.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:06.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:06.67   Activating screen: OnlineSelectGame
18:18:06.67   Activating screen: RelicOnlineTabs
18:18:06.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:06.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:06.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:13.21   CancelAutoMatching - called
18:18:13.21   Activating screen: OnlineSelectGame
18:18:13.21   Activating screen: RelicOnlineTabs
18:18:13.21   Activating screen: FEMovie
18:18:13.21   Activating screen: OnlineWidget
18:18:13.21   Activating screen: FE_mm_01
18:18:13.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:13.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:13.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:13.21   GAME -- Setting campaign state to 'dlc1'
18:18:13.21   GAME -- Closing state 'dlc1'
18:18:13.21   GAME -- Setting campaign state to 'dlc2'
18:18:13.21   GAME -- Closing state 'dlc2'
18:18:13.21   GAME -- Setting campaign state to 'dlc3'
18:18:13.21   GAME -- Closing state 'dlc3'
18:18:19.17   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
18:18:19.17   Activating screen: OnlineSelectGame
18:18:19.18   Activating screen: RelicOnlineChat
18:18:19.18   Activating screen: RelicOnlineNewsScreen
18:18:19.18   Activating screen: RelicOnlineStatsScreen
18:18:19.18   Activating screen: Achievements
18:18:19.18   GAME -- Setting campaign state to 'dlc1'
18:18:19.18   GAME -- Closing state 'dlc1'
18:18:19.18   GAME -- Setting campaign state to 'dlc2'
18:18:19.18   GAME -- Closing state 'dlc2'
18:18:19.18   GAME -- Setting campaign state to 'dlc3'
18:18:19.18   GAME -- Closing state 'dlc3'
18:18:19.19   Activating screen: GameHistory
18:18:19.19   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:19.19   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:19.19   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:19.19   Activating screen: OnlineSelectGame
18:18:19.19   Activating screen: RelicOnlineTabs
18:18:32.01   CancelAutoMatching - called
18:18:32.01   Activating screen: OnlineSelectGame
18:18:32.01   Activating screen: RelicOnlineTabs
18:18:32.01   Activating screen: FEMovie
18:18:32.01   Activating screen: OnlineWidget
18:18:32.01   Activating screen: FE_mm_01
18:18:32.01   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:32.01   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:32.01   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:32.02   GAME -- Setting campaign state to 'dlc1'
18:18:32.02   GAME -- Closing state 'dlc1'
18:18:32.02   GAME -- Setting campaign state to 'dlc2'
18:18:32.02   GAME -- Closing state 'dlc2'
18:18:32.02   GAME -- Setting campaign state to 'dlc3'
18:18:32.02   GAME -- Closing state 'dlc3'
18:18:34.60   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
18:18:34.60   Activating screen: OnlineSelectGame
18:18:34.60   Activating screen: RelicOnlineChat
18:18:34.60   Activating screen: RelicOnlineNewsScreen
18:18:34.60   Activating screen: RelicOnlineStatsScreen
18:18:34.60   Activating screen: Achievements
18:18:34.60   GAME -- Setting campaign state to 'dlc1'
18:18:34.60   GAME -- Closing state 'dlc1'
18:18:34.60   GAME -- Setting campaign state to 'dlc2'
18:18:34.60   GAME -- Closing state 'dlc2'
18:18:34.61   GAME -- Setting campaign state to 'dlc3'
18:18:34.61   GAME -- Closing state 'dlc3'
18:18:34.61   Activating screen: GameHistory
18:18:34.61   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:34.61   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:34.61   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:34.61   Activating screen: OnlineSelectGame
18:18:34.61   Activating screen: RelicOnlineTabs
18:18:38.60   CancelAutoMatching - called
18:18:38.60   Activating screen: OnlineSelectGame
18:18:38.60   Activating screen: RelicOnlineTabs
18:18:38.60   Activating screen: FEMovie
18:18:38.60   Activating screen: OnlineWidget
18:18:38.60   Activating screen: FE_mm_01
18:18:38.60   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:38.60   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:38.60   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:38.60   GAME -- Setting campaign state to 'dlc1'
18:18:38.60   GAME -- Closing state 'dlc1'
18:18:38.61   GAME -- Setting campaign state to 'dlc2'
18:18:38.61   GAME -- Closing state 'dlc2'
18:18:38.61   GAME -- Setting campaign state to 'dlc3'
18:18:38.61   GAME -- Closing state 'dlc3'
18:18:42.41   Transport::OpenInternal request to WINaddr:7.19.56.165:6112;
18:18:42.42   Transport - Largest sent is now 19
18:18:42.93   Transport - Largest received is now 30
18:18:42.94   Transport - Largest sent is now 30
18:18:43.45   SPDx9 -- 1770MB available Texture Memory
18:18:45.20   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
18:18:45.20   Activating screen: OnlineSelectGame
18:18:45.20   Activating screen: RelicOnlineChat
18:18:45.20   Activating screen: RelicOnlineNewsScreen
18:18:45.21   Activating screen: RelicOnlineStatsScreen
18:18:45.21   Activating screen: Achievements
18:18:45.21   GAME -- Setting campaign state to 'dlc1'
18:18:45.21   GAME -- Closing state 'dlc1'
18:18:45.21   GAME -- Setting campaign state to 'dlc2'
18:18:45.21   GAME -- Closing state 'dlc2'
18:18:45.21   GAME -- Setting campaign state to 'dlc3'
18:18:45.21   GAME -- Closing state 'dlc3'
18:18:45.22   Activating screen: GameHistory
18:18:45.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:45.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:45.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:18:45.22   Activating screen: OnlineSelectGame
18:18:45.22   Activating screen: RelicOnlineTabs
18:18:45.30   Transport::OpenInternal request to WINaddr:7.3.10.178:6112;
18:18:46.14   Transport::OpenInternal request to WINaddr:7.4.44.217:6112;
18:18:47.00   Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.1/0.4, max unsent 0, version err 0, merge 3
18:18:47.21   Transport::OpenInternal request to WINaddr:7.17.24.254:6112;
18:18:47.22   Transport::OpenInternal request to WINaddr:7.15.186.231:6112;
18:18:47.35   Transport::OpenInternal request to WINaddr:7.5.200.139:6112;
18:18:47.35   Transport::OpenInternal request to WINaddr:7.19.57.54:6112;
18:18:47.42   Transport::OpenInternal request to WINaddr:7.19.44.20:6112;
18:18:47.43   Transport::OpenInternal request to WINaddr:7.15.218.191:6112;
18:18:47.43   Transport::OpenInternal request to WINaddr:7.6.42.77:6112;
18:18:47.45   Transport::OpenInternal request to WINaddr:7.12.151.98:6112;
18:18:47.49   Transport::OpenInternal request to WINaddr:7.12.152.147:6112;
18:18:47.49   Transport::OpenInternal request to WINaddr:7.17.121.183:6112;
18:18:47.54   Transport::OpenInternal request to WINaddr:7.12.189.1:6112;
18:18:49.25   Transport::OpenInternal request to WINaddr:7.19.2.89:6112;
18:18:49.37   Transport - Largest received is now 821
18:18:49.37   Transport::OpenInternal request to WINaddr:7.14.125.150:6112;
18:18:49.42   Transport::OpenInternal request to WINaddr:7.17.248.140:6112;
18:18:49.55   Transport::OpenInternal request to WINaddr:7.6.38.246:6112;
18:18:49.65   Transport::OpenInternal request to WINaddr:7.14.240.97:6112;
18:18:49.67   Transport::OpenInternal request to WINaddr:7.10.160.241:6112;
18:18:49.74   Transport::OpenInternal request to WINaddr:7.10.225.145:6112;
18:18:51.02   SPDx9 -- 1770MB available Texture Memory
18:18:51.14   Transport::OpenInternal request to WINaddr:7.14.69.246:6112;
18:18:51.21   Transport::OpenInternal request to WINaddr:7.18.126.35:6112;
18:18:51.23   Transport::OpenInternal request to WINaddr:7.18.82.167:6112;
18:18:51.26   Transport::OpenInternal request to WINaddr:7.6.235.7:6112;
18:18:51.46   Transport::OpenInternal request to WINaddr:7.1.3.188:6112;
18:18:51.56   Transport::OpenInternal request to WINaddr:7.19.25.22:6112;
18:18:51.75   Transport::OpenInternal request to WINaddr:7.17.97.28:6112;
18:18:51.98   Transport::OpenInternal request to WINaddr:7.19.24.103:6112;
18:18:52.46   Transport::OpenInternal request to WINaddr:7.19.15.191:6112;
18:18:52.77   Transport::OpenInternal request to WINaddr:7.18.238.189:6112;
18:18:53.11   Transport::OpenInternal request to WINaddr:7.5.229.41:6112;
18:18:53.84   Transport::OpenInternal request to WINaddr:7.19.24.118:6112;
18:18:56.34   Transport::OpenInternal request to WINaddr:7.12.71.15:6112;
18:18:57.46   Transport::OpenInternal request to WINaddr:7.13.135.139:6112;
18:18:57.49   Transport::OpenInternal request to WINaddr:7.8.118.161:6112;
18:18:57.78   Transport::OpenInternal request to WINaddr:7.7.6.225:6112;
18:19:02.55   Transport::OpenInternal request to WINaddr:7.14.201.162:6112;
18:19:13.60   Transport - Largest received is now 1100
18:19:13.60   Transport::OpenInternal request to WINaddr:7.5.36.253:6112;
18:19:13.80   Transport::OpenInternal request to WINaddr:7.11.55.164:6112;
18:19:14.34   Transport::OpenInternal request to WINaddr:7.5.100.170:6112;
18:19:14.41   Transport::OpenInternal request to WINaddr:7.5.100.207:6112;
18:19:14.42   Transport::OpenInternal request to WINaddr:7.10.231.191:6112;
18:19:14.42   Transport::OpenInternal request to WINaddr:7.8.234.24:6112;
18:19:17.44   Transport::OpenInternal request to WINaddr:7.9.77.214:6112;
18:19:48.01   Transport - median kBPS [hi/cur] sent = 0.4/0.2, recvd = 1.8/1.2, #p/sec[s/r] = 9.5/5.1, max unsent 0, version err 0, merge 40
18:20:08.12   Transport::OpenInternal request to WINaddr:7.13.204.71:6112;
18:20:36.63   SPDx9 -- 1770MB available Texture Memory
18:20:41.91   JoinAsync: Starting AsyncJob...
18:20:41.91   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
18:20:41.91   Created Matchinfo
18:20:41.95   Activating screen: MessageBoxPopup
18:20:41.98   OnlineJoinAsync success
18:20:41.98   OnJoinAdvertisementSuccess - joined online match, server leave notification required
18:20:42.02   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:20:42.02   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:20:42.02   Allocated route ID=0 for PeerID 0 at WINaddr:7.19.62.180:6112;
18:20:42.02   Transport::OpenInternal request to WINaddr:7.19.62.180:6112;
18:20:42.02   Allocated route ID=0 for PeerID 0 at WINaddr:7.5.36.253:6112;
18:20:42.02   Transport::OpenInternal request to WINaddr:7.5.36.253:6112;
18:20:42.02   Session::Connect sid = 596C6350E80BEB9C, hostURL = WINaddr:7.5.36.253:6112;, local addresses = WINaddr:7.19.62.180:6112;
18:20:42.03   Transport - Largest sent is now 192
18:20:42.04   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
18:20:42.62   Transport - Largest received is now 1124
18:20:42.63   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the local peer
18:20:42.63   Session - highest peerID now : 3
18:20:42.63   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the host
18:20:42.64   ValidateCustomData: called with 210 bytes of custom data
18:20:42.64   Client accepted Peer 3 into the match at address list = WINaddr:7.19.62.180:6112;, routes = WINaddr:7.19.62.180:6112;
18:20:42.64   Session::GetEvent - probing service provided NAT'd routes
18:20:42.64   AdvertisementInternal::Process - EVENT_NEWPEER
18:20:42.64   ValidateCustomData: called with 272 bytes of custom data
18:20:42.64   Client accepted Peer 1 into the match at address list = WINaddr:7.5.36.253:6112;, routes = WINaddr:7.5.36.253:6112;
18:20:42.64   AdvertisementInternal::Process - EVENT_NEWPEER
18:20:42.64   Accepted matchInfo updated 71 from host
18:20:42.66   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
18:20:42.67   Accepted matchInfo updated 73 from host
18:20:42.67   JoinAsync - got operation info 0:SessionOperationInfo::SUCCESS
18:20:42.67   local      PeerID 3 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
18:20:42.67         host PeerID 1 CONN ack=  0 (  0ms~0) unack=  4, retry=  0, highwaterOOS=0 @WINaddr:7.5.36.253:6112; (ping=439ms) 100.00%, pending=0, dead=0
18:20:42.67   MessageCounts: inval=0/0, seek=0/1, 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/0, Errors=0/0
18:20:42.70   JoinAsync - completed with JoinResult = 0:JoinEvent::R_Success
18:20:42.70   Activating screen: OnlineGameSetup
18:20:42.70   Activating screen: RelicOnlineTabs
18:20:42.70   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
18:20:42.70   JoinAsync: AsyncJob Complete...
18:20:42.72   MessageInternal::CreateChannel: Created channel 534d5347
18:20:42.72   Map 4p_coastal_harbour does not have a valid operation type
18:20:42.72   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:20:42.73   Transport - Largest sent is now 515
18:20:43.14   Accepted matchInfo updated 74 from host
18:20:43.34   Accepted matchInfo updated 76 from host
18:20:43.34   Accepted matchInfo updated 78 from host
18:20:43.35   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:20:44.02   Accepted matchInfo updated 81 from host
18:20:48.48   Activating screen: MessageBoxPopup
18:20:48.48   Session is marking PeerID 1 for death
18:20:48.48   Session is marking the local peer PeerID 3 for death
18:20:48.48   Session::GetEvent DestroyPeer success Peer 1 removed
18:20:48.48   Session::DestroyPeer - deallocating peer 1
18:20:48.48   Session - Requested Disconnect for connectionID 3
18:20:48.48   Deallocated route ID=5 for PeerID 1 at WINaddr:7.5.36.253:6112;
18:20:48.48   Session - Requested Disconnect for connectionID 5
18:20:48.48   Closed route 5<>7 for PeerID 1 at WINaddr:7.5.36.253:6112;
18:20:48.48   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:20:48.48   Session::GetEvent DestroyPeer success Peer 3 removed
18:20:48.48   Session::DestroyPeer - deallocating peer 3
18:20:48.48   Session - Requested Disconnect for connectionID 2
18:20:48.48   Deallocated route ID=4 for PeerID 3 at WINaddr:7.19.62.180:6112;
18:20:48.48   Session - Requested Disconnect for connectionID 4
18:20:48.48   Closed route 4<>4 for PeerID 3 at WINaddr:7.19.62.180:6112;
18:20:48.48   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:20:48.48   Destroyed Matchinfo
18:20:48.49   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
18:20:48.49   PeerRemoveAll - flushing local session peer data
18:20:48.49   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
18:20:48.50   Activating screen: OnlineSelectGame
18:20:48.50   Activating screen: RelicOnlineTabs
18:20:48.51   MessageInternal::DestroyChannel: Destroyed channel 534d5347
18:20:49.01   Transport - median kBPS [hi/cur] sent = 0.6/0.2, recvd = 4.7/0.9, #p/sec[s/r] = 8.6/3.6, max unsent 0, version err 0, merge 11
18:20:49.07   Session - Expected ConnectionID 5 doesn't exist, will close remote.
18:20:49.77   Transport - Largest received is now 1126
18:20:53.00   Activating screen: OnlineGameCreate
18:20:53.00   Activating screen: RelicOnlineTabs
18:20:59.11   Activating screen: MessageBoxPopup
18:20:59.11   Created Matchinfo
18:20:59.11   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
18:20:59.11   starting LAN hosting
18:20:59.14   OnJoinAdvertisementSuccess - joined online match, server leave notification required
18:20:59.14   starting local hosting
18:20:59.14   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:20:59.14   Allocated route ID=0 for PeerID 1 at WINaddr:7.19.62.180:6112;
18:20:59.14   Transport::OpenInternal request to WINaddr:7.19.62.180:6112;
18:20:59.14   Session::Host sid = 479D9538FC68CE94, hostURL = , local addresses = WINaddr:7.19.62.180:6112;
18:20:59.14   ValidateCustomData: called with 210 bytes of custom data
18:20:59.14   Host accepted Peer 1 into the match at address list=WINaddr:7.19.62.180:6112;, routes=WINaddr:7.19.62.180:6112;
18:20:59.14   AdvertisementInternal::Process - EVENT_NEWPEER
18:20:59.14   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
18:20:59.16   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
18:20:59.16   hosting - Session is connected
18:20:59.16   Net::Session::SetVisible - session is set to VISIBLE.
18:20:59.17   hosting completed successfully
18:20:59.17   HostAsync - completed with HostResult = 0
18:20:59.17   Activating screen: OnlineGameSetup
18:20:59.17   Activating screen: RelicOnlineTabs
18:20:59.17   AutomatchInternal::OnHostComplete - Completed Host with success=1
18:20:59.17   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
18:20:59.17   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
18:20:59.18   local host PeerID 1 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
18:20:59.18   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=1/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
18:20:59.19   MessageInternal::CreateChannel: Created channel 534d5347
18:20:59.19   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
18:20:59.22   Net::Session::SetVisible - session is set to VISIBLE.
18:20:59.22   GetMaxFrameTimeFromProfile: players=2 expected FPS=19.319939, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
18:20:59.23   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
18:20:59.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:20:59.24   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
18:20:59.24   Net::Session::SetVisible - session is set to VISIBLE.
18:20:59.24   GetMaxFrameTimeFromProfile: players=2 expected FPS=19.319939, bars=5, max avg=0.052, sd=0.000, 1 samples =  0.05
18:20:59.30   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:20:59.34   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:21:20.45   Activating screen: MessageBoxPopup
18:21:20.45   Session is marking the local peer PeerID 1 for death
18:21:20.45   Session::GetEvent DestroyPeer success Peer 1 removed
18:21:20.45   Session::DestroyPeer - deallocating peer 1
18:21:20.45   Session - Requested Disconnect for connectionID 6
18:21:20.45   Deallocated route ID=7 for PeerID 1 at WINaddr:7.19.62.180:6112;
18:21:20.45   Session - Requested Disconnect for connectionID 7
18:21:20.45   Closed route 7<>7 for PeerID 1 at WINaddr:7.19.62.180:6112;
18:21:20.45   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:21:20.45   Destroyed Matchinfo
18:21:20.47   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
18:21:20.47   PeerRemoveAll - flushing local session peer data
18:21:20.47   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
18:21:20.48   Activating screen: OnlineSelectGame
18:21:20.48   Activating screen: RelicOnlineTabs
18:21:20.50   MessageInternal::DestroyChannel: Destroyed channel 534d5347
18:21:22.47   JoinAsync: Starting AsyncJob...
18:21:22.47   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
18:21:22.47   Created Matchinfo
18:21:22.50   Activating screen: MessageBoxPopup
18:21:22.53   OnlineJoinAsync success
18:21:22.53   OnJoinAdvertisementSuccess - joined online match, server leave notification required
18:21:22.55   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:21:22.55   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:21:22.55   Allocated route ID=0 for PeerID 0 at WINaddr:7.19.62.180:6112;
18:21:22.55   Transport::OpenInternal request to WINaddr:7.19.62.180:6112;
18:21:22.55   Allocated route ID=0 for PeerID 0 at WINaddr:7.11.55.164:6112;
18:21:22.55   Transport::OpenInternal request to WINaddr:7.11.55.164:6112;
18:21:22.55   Session::Connect sid = 1E6379507C32F14A, hostURL = WINaddr:7.11.55.164:6112;, local addresses = WINaddr:7.19.62.180:6112;
18:21:22.57   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
18:21:23.38   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the local peer
18:21:23.38   Session - highest peerID now : 2
18:21:23.38   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the host
18:21:23.39   ValidateCustomData: called with 210 bytes of custom data
18:21:23.39   Client accepted Peer 2 into the match at address list = WINaddr:7.19.62.180:6112;, routes = WINaddr:7.19.62.180:6112;
18:21:23.39   Session::GetEvent - probing service provided NAT'd routes
18:21:23.39   AdvertisementInternal::Process - EVENT_NEWPEER
18:21:23.39   ValidateCustomData: called with 174 bytes of custom data
18:21:23.39   Client accepted Peer 1 into the match at address list = WINaddr:7.11.55.164:6112;, routes = WINaddr:7.11.55.164:6112;
18:21:23.39   AdvertisementInternal::Process - EVENT_NEWPEER
18:21:23.39   Accepted matchInfo updated 34 from host
18:21:23.40   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
18:21:23.40   JoinAsync - got operation info 0:SessionOperationInfo::SUCCESS
18:21:23.42   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
18:21:23.42         host PeerID 1 CONN ack=  0 (  0ms~0) unack=  3, retry=  1, highwaterOOS=0 @WINaddr:7.11.55.164:6112; (ping=445ms) 75.00%, pending=0, dead=0
18:21:23.42   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=1/1, voice=0/0, rchk=1/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=21/4, frag=0/0, Errors=0/0
18:21:23.42   JoinAsync - completed with JoinResult = 0:JoinEvent::R_Success
18:21:23.42   Activating screen: OnlineGameSetup
18:21:23.42   Activating screen: RelicOnlineTabs
18:21:23.42   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
18:21:23.42   JoinAsync: AsyncJob Complete...
18:21:23.43   MessageInternal::CreateChannel: Created channel 534d5347
18:21:23.43   Map 4p_ecliptic_fields does not have a valid operation type
18:21:23.43   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:21:24.65   Transport - Largest received is now 1314
18:21:24.67   Accepted matchInfo updated 36 from host
18:21:24.73   Accepted matchInfo updated 37 from host
18:21:24.73   Accepted matchInfo updated 39 from host
18:21:24.73   Accepted matchInfo updated 41 from host
18:21:24.73   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:21:25.94   Accepted matchInfo updated 44 from host
18:21:38.66   Accepted matchInfo updated 45 from host
18:21:50.00   Transport - median kBPS [hi/cur] sent = 0.9/0.1, recvd = 4.7/0.0, #p/sec[s/r] = 8.8/3.6, max unsent 0, version err 0, merge 17
18:22:19.65   Activating screen: Achievements
18:22:19.65   Activating screen: RelicOnlineTabs
18:22:24.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
18:22:24.00         host PeerID 1 CONN ack=  0 (473ms~0) unack=  0, retry= 14, highwaterOOS=2 @WINaddr:7.11.55.164:6112; (ping=439ms) 54.84%, pending=0, dead=0
18:22:24.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/13, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=14/7, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=500/119, frag=0/25, Errors=0/0
18:22:27.54   Activating screen: OnlineGameSetup
18:22:27.54   Activating screen: RelicOnlineTabs
18:22:51.00   Transport - median kBPS [hi/cur] sent = 0.9/0.1, recvd = 4.7/0.0, #p/sec[s/r] = 8.4/2.9, max unsent 0, version err 0, merge 0
18:22:51.12   Activating screen: Achievements
18:22:51.12   Activating screen: RelicOnlineTabs
18:23:00.61   Activating screen: OnlineGameSetup
18:23:00.61   Activating screen: RelicOnlineTabs
18:23:09.19   Activating screen: GameHistory
18:23:09.19   Activating screen: RelicOnlineTabs
18:23:09.19   Activating screen: ScreenTipPopup
18:23:11.59   Activating screen: OnlineGameSetup
18:23:11.59   Activating screen: RelicOnlineTabs
18:23:12.74   Activating screen: Achievements
18:23:12.74   Activating screen: RelicOnlineTabs
18:23:25.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
18:23:25.01         host PeerID 1 CONN ack=  0 (473ms~0) unack=  0, retry= 14, highwaterOOS=2 @WINaddr:7.11.55.164:6112; (ping=439ms) 56.25%, pending=0, dead=0
18:23:25.01   MessageCounts: inval=0/0, seek=0/8, join=0/0, integ=0/0, seek_reply=0/21, 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=503/115, frag=0/46, Errors=0/0
18:23:26.60   Activating screen: OnlineGameSetup
18:23:26.60   Activating screen: RelicOnlineTabs
18:23:27.65   Activating screen: RaceSelectionPopup
18:23:29.89   Accepted matchInfo updated 46 from host
18:23:29.90   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:23:29.91   Accepted matchInfo updated 48 from host
18:23:31.09   Accepted matchInfo updated 51 from host
18:23:31.47   Accepted matchInfo updated 52 from host
18:23:35.72   Activating screen: Achievements
18:23:35.72   Activating screen: RelicOnlineTabs
18:23:52.01   Transport - median kBPS [hi/cur] sent = 0.9/0.2, recvd = 4.7/0.1, #p/sec[s/r] = 8.8/3.5, max unsent 0, version err 0, merge 9
18:24:06.39   Activating screen: OnlineGameSetup
18:24:06.39   Activating screen: RelicOnlineTabs
18:24:26.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
18:24:26.01         host PeerID 1 CONN ack=  0 (1537ms~0) unack=  0, retry= 22, highwaterOOS=2 @WINaddr:7.11.55.164:6112; (ping=443ms) 56.86%, pending=0, dead=0
18:24:26.01   MessageCounts: inval=0/0, seek=0/5, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=11/4, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=506/118, frag=0/16, Errors=0/0
18:24:27.35   Activating screen: Achievements
18:24:27.35   Activating screen: RelicOnlineTabs
18:24:44.36   Activating screen: OnlineGameSetup
18:24:44.36   Activating screen: RelicOnlineTabs
18:24:53.01   Transport - median kBPS [hi/cur] sent = 0.9/0.2, recvd = 4.7/0.1, #p/sec[s/r] = 8.6/2.6, max unsent 0, version err 0, merge 0
18:24:55.56   Activating screen: GameHistory
18:24:55.56   Activating screen: RelicOnlineTabs
18:24:55.56   Activating screen: ScreenTipPopup
18:24:57.47   Activating screen: OnlineGameSetup
18:24:57.47   Activating screen: RelicOnlineTabs
18:24:58.21   Session::SelectNewSessionHost - Select peer 2 to be next host (previously peer 1)
18:24:58.21   Session::ProcessPeerMessages LocalPeer is marking PeerID 1 for death on instruction from Host
18:24:58.23   Closed route 11<>15 by remote request for PeerID 1 at WINaddr:7.11.55.164:6112;
18:24:58.23   AdvertisementInternal::Process - EVENT_HOSTMIGRATION
18:24:58.23   MatchInternal::OnHostMigration - Hosting has migrated to us, updating match info
18:24:58.23   Session::GetEvent DestroyPeer success Peer 1 removed
18:24:58.23   Session::DestroyPeer - deallocating peer 1
18:24:58.23   Session - Requested Disconnect for connectionID 9
18:24:58.23   Deallocated route ID=11 for PeerID 1 at WINaddr:7.11.55.164:6112;
18:24:58.23   Session - Requested Disconnect for connectionID 11
18:24:58.23   Closed route 11<>15 for PeerID 1 at WINaddr:7.11.55.164:6112;
18:24:58.23   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:24:58.23   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
18:24:58.24   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
18:24:58.24   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:24:58.25   Activating screen: MessageBoxPopup
18:24:58.25   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:24:58.26   Session is marking the local peer PeerID 2 for death
18:24:58.26   Session::GetEvent DestroyPeer success Peer 2 removed
18:24:58.26   Session::DestroyPeer - deallocating peer 2
18:24:58.26   Session - Requested Disconnect for connectionID 8
18:24:58.26   Deallocated route ID=10 for PeerID 2 at WINaddr:7.19.62.180:6112;
18:24:58.26   Session - Requested Disconnect for connectionID 10
18:24:58.26   Closed route 10<>10 for PeerID 2 at WINaddr:7.19.62.180:6112;
18:24:58.26   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:24:58.26   Destroyed Matchinfo
18:24:58.27   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
18:24:58.27   PeerRemoveAll - flushing local session peer data
18:24:58.27   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
18:24:58.29   Activating screen: OnlineSelectGame
18:24:58.29   Activating screen: RelicOnlineTabs
18:24:58.29   MessageInternal::DestroyChannel: Destroyed channel 534d5347
18:25:04.31   JoinAsync: Starting AsyncJob...
18:25:04.31   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
18:25:04.31   Created Matchinfo
18:25:04.34   Activating screen: MessageBoxPopup
18:25:04.36   OnlineJoinAsync success
18:25:04.36   OnJoinAdvertisementSuccess - joined online match, server leave notification required
18:25:04.37   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:25:04.37   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:25:04.37   Allocated route ID=0 for PeerID 0 at WINaddr:7.19.62.180:6112;
18:25:04.37   Transport::OpenInternal request to WINaddr:7.19.62.180:6112;
18:25:04.37   Allocated route ID=0 for PeerID 0 at WINaddr:7.11.55.164:6112;
18:25:04.37   Transport::OpenInternal request to WINaddr:7.11.55.164:6112;
18:25:04.37   Session::Connect sid = 2B654E6D07153EF, hostURL = WINaddr:7.11.55.164:6112;, local addresses = WINaddr:7.19.62.180:6112;
18:25:04.39   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
18:25:05.57   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the local peer
18:25:05.57   Session - highest peerID now : 3
18:25:05.57   Session::PollTransportEvents AddPeerMessage from peer 0 recv'd for existing pending peer 0, the host
18:25:05.57   Session::PollTransportEvents AddPeerMessage from peer 1 recv'd for unknown peer at address list WINaddr:7.11.193.122:6112;
18:25:05.57   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
18:25:05.57   Session::CheckAddress - initiating address check for WINaddr:7.11.193.122:6112;
18:25:05.57   ValidateCustomData: called with 210 bytes of custom data
18:25:05.57   Client accepted Peer 3 into the match at address list = WINaddr:7.19.62.180:6112;, routes = WINaddr:7.19.62.180:6112;
18:25:05.57   Session::GetEvent - probing service provided NAT'd routes
18:25:05.57   AdvertisementInternal::Process - EVENT_NEWPEER
18:25:05.57   ValidateCustomData: called with 174 bytes of custom data
18:25:05.57   Client accepted Peer 1 into the match at address list = WINaddr:7.11.55.164:6112;, routes = WINaddr:7.11.55.164:6112;
18:25:05.57   AdvertisementInternal::Process - EVENT_NEWPEER
18:25:05.57   ValidateCustomData: called with 192 bytes of custom data
18:25:05.57   Client accepted Peer 2 into the match at address list = WINaddr:7.11.193.122:6112;, routes =
18:25:05.57   AdvertisementInternal::Process - EVENT_NEWPEER
18:25:05.57   Accepted matchInfo updated 42 from host
18:25:05.59   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
18:25:05.60   JoinAsync - got operation info 0:SessionOperationInfo::SUCCESS
18:25:05.61   JoinAsync - completed with JoinResult = 0:JoinEvent::R_Success
18:25:05.61   Activating screen: OnlineGameSetup
18:25:05.61   Activating screen: RelicOnlineTabs
18:25:05.61   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
18:25:05.61   JoinAsync: AsyncJob Complete...
18:25:05.61   local      PeerID 3 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
18:25:05.61         host PeerID 1 CONN ack=  0 (  0ms~0) unack=  3, retry=  1, highwaterOOS=0 @WINaddr:7.11.55.164:6112; (ping=437ms) 75.00%, pending=0, dead=0
18:25:05.61              PeerID 2 PROX ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:7.11.193.122:6112;), pending=0, dead=0
18:25:05.61   MessageCounts: inval=0/0, seek=0/0, join=1/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/3, remove=0/0, drop=0/0, data=1/1, voice=0/0, rchk=1/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=15/0, frag=0/3, Errors=0/0
18:25:05.62   MessageInternal::CreateChannel: Created channel 534d5347
18:25:05.62   Map 4p_ecliptic_fields does not have a valid operation type
18:25:05.62   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:25:06.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:07.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:07.10   Accepted matchInfo updated 44 from host
18:25:07.10   Accepted matchInfo updated 47 from host
18:25:07.12   Accepted matchInfo updated 50 from host
18:25:07.57   Accepted matchInfo updated 52 from host
18:25:07.57   Accepted matchInfo updated 54 from host
18:25:07.57   Accepted matchInfo updated 57 from host
18:25:07.57   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:25:08.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:08.81   Accepted matchInfo updated 60 from host
18:25:09.01   Activating screen: RaceSelectionPopup
18:25:09.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:10.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:11.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:11.70   Accepted matchInfo updated 61 from host
18:25:11.70   Accepted matchInfo updated 63 from host
18:25:11.70   Accepted matchInfo updated 66 from host
18:25:11.70   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:25:12.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:12.91   Accepted matchInfo updated 69 from host
18:25:13.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:14.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:14.98   Accepted matchInfo updated 70 from host
18:25:15.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:16.01   Session::ProcessCheckAddressList - sending address check to WINaddr:7.11.193.122:6112;
18:25:16.01   Session::ProcessCheckAddressList - address WINaddr:7.11.193.122:6112; timed out
18:25:19.51   Accepted matchInfo updated 71 from host
18:25:19.51   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:25:19.56   Accepted matchInfo updated 73 from host
18:25:19.56   Accepted matchInfo updated 76 from host
18:25:19.75   Accepted matchInfo updated 77 from host
18:25:20.75   Accepted matchInfo updated 80 from host
18:25:21.55   Accepted matchInfo updated 81 from host
18:25:32.39   Accepted matchInfo updated 82 from host
18:25:32.40   GetMaxFrameTimeFromProfile: players=4 expected FPS=17.188038, bars=5, max avg=0.057, sd=0.001, 2 samples =  0.06 0.06
18:25:33.23   Accepted matchInfo updated 84 from host
18:25:33.23   Accepted matchInfo updated 87 from host
18:25:33.63   Accepted matchInfo updated 90 from host
18:25:37.92   Accepted matchInfo updated 91 from host
18:25:41.79   Activating screen: MessageBoxPopup
18:25:41.79   Session is marking PeerID 1 for death
18:25:41.79   Session is marking PeerID 2 for death
18:25:41.79   Session is marking the local peer PeerID 3 for death
18:25:41.79   Session::GetEvent DestroyPeer success Peer 1 removed
18:25:41.79   Session::DestroyPeer - deallocating peer 1
18:25:41.79   Session - Requested Disconnect for connectionID 13
18:25:41.79   Deallocated route ID=15 for PeerID 1 at WINaddr:7.11.55.164:6112;
18:25:41.79   Session - Requested Disconnect for connectionID 15
18:25:41.79   Closed route 15<>21 for PeerID 1 at WINaddr:7.11.55.164:6112;
18:25:41.79   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:25:41.79   Session::GetEvent DestroyPeer success Peer 2 removed
18:25:41.79   Session::DestroyPeer - deallocating peer 2
18:25:41.79   Session - Requested Disconnect for connectionID 16
18:25:41.79   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:25:41.79   Session::GetEvent DestroyPeer success Peer 3 removed
18:25:41.79   Session::DestroyPeer - deallocating peer 3
18:25:41.79   Session - Requested Disconnect for connectionID 12
18:25:41.79   Deallocated route ID=14 for PeerID 3 at WINaddr:7.19.62.180:6112;
18:25:41.79   Session - Requested Disconnect for connectionID 14
18:25:41.79   Closed route 14<>14 for PeerID 3 at WINaddr:7.19.62.180:6112;
18:25:41.79   AdvertisementInternal::Process - EVENT_DESTROYPEER
18:25:41.79   Destroyed Matchinfo
18:25:41.80   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
18:25:41.80   PeerRemoveAll - flushing local session peer data
18:25:41.80   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
18:25:41.80   Activating screen: FEMovie
18:25:41.80   Activating screen: OnlineWidget
18:25:41.80   Activating screen: FE_mm_01
18:25:41.82   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:25:41.82   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:25:41.82   GameInfo::ResetInfo - SyncLevel set to 0 on reset
18:25:41.82   MessageInternal::DestroyChannel: Destroyed channel 534d5347
18:25:41.83   GAME -- Setting campaign state to 'dlc1'
18:25:41.83   GAME -- Closing state 'dlc1'
18:25:41.83   GAME -- Setting campaign state to 'dlc2'
18:25:41.83   GAME -- Closing state 'dlc2'
18:25:41.83   GAME -- Setting campaign state to 'dlc3'
18:25:41.83   GAME -- Closing state 'dlc3'
18:25:43.00   Activating screen: QuitPromptDialog
18:25:44.15   GameApp::Quit( exitValue = 0 )
18:25:44.17   GameApp::ShutFrontEnd
18:25:44.18   GAME -- Ending FE
18:25:44.18   UIFrontEnd - Unloading Front End
18:25:44.20   SOUND -- Shutting down ...
18:25:44.24   SOUND -- Shutdown completed!
18:25:44.29   ~FEAppListener - Flushing queued online notifications
18:25:44.39   DLLDriverLinker -- 2 DLL drivers found.
18:25:44.39   ActionDatabase : [2348] global actions, [0] dummy actions.
18:25:44.39   NetworkManager::Destroy - destroying network manager
18:25:44.39   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
18:25:44.39   MessageInternal::DestroyChannel: Destroyed channel 50525459
18:25:44.39   PartyInternal: Fade to black
18:25:44.39   AutomatchInternal: Fade to black
18:25:44.39   PeerRemoveAll - flushing local session peer data
18:25:44.39   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
18:25:44.39   MessageInternal::DestroyChannel: Destroyed channel 47535450
18:25:44.39   Session - Requested Disconnect for connectionID 1
18:25:44.39   SessionManager::UnregisterSession - Unregistering session 07262e40
18:25:44.39   SessionManager::~SessionManager - uninitializing
18:25:44.40   Net::ThreadFunction - Returning from the network thread function...
18:25:44.40   Transport::~Transport - shutting down transport
18:25:44.40   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.62.180:6112;,WINaddr:7.19.62.180:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.56.165:6112;,WINaddr:7.19.56.165:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.3.10.178:6112;,WINaddr:7.3.10.178:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.4.44.217:6112;,WINaddr:7.4.44.217:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.17.24.254:6112;,WINaddr:7.17.24.254:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.15.186.231:6112;,WINaddr:7.15.186.231:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.5.200.139:6112;,WINaddr:7.5.200.139:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.57.54:6112;,WINaddr:7.19.57.54:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.44.20:6112;,WINaddr:7.19.44.20:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.15.218.191:6112;,WINaddr:7.15.218.191:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.6.42.77:6112;,WINaddr:7.6.42.77:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.12.151.98:6112;,WINaddr:7.12.151.98:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.12.152.147:6112;,WINaddr:7.12.152.147:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.17.121.183:6112;,WINaddr:7.17.121.183:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.12.189.1:6112;,WINaddr:7.12.189.1:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.2.89:6112;,WINaddr:7.19.2.89:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.14.125.150:6112;,WINaddr:7.14.125.150:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.17.248.140:6112;,WINaddr:7.17.248.140:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.6.38.246:6112;,WINaddr:7.6.38.246:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.14.240.97:6112;,WINaddr:7.14.240.97:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.10.160.241:6112;,WINaddr:7.10.160.241:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.10.225.145:6112;,WINaddr:7.10.225.145:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.14.69.246:6112;,WINaddr:7.14.69.246:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.18.126.35:6112;,WINaddr:7.18.126.35:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.18.82.167:6112;,WINaddr:7.18.82.167:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.6.235.7:6112;,WINaddr:7.6.235.7:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.1.3.188:6112;,WINaddr:7.1.3.188:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.25.22:6112;,WINaddr:7.19.25.22:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.17.97.28:6112;,WINaddr:7.17.97.28:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.24.103:6112;,WINaddr:7.19.24.103:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.15.191:6112;,WINaddr:7.19.15.191:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.18.238.189:6112;,WINaddr:7.18.238.189:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.5.229.41:6112;,WINaddr:7.5.229.41:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.19.24.118:6112;,WINaddr:7.19.24.118:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.12.71.15:6112;,WINaddr:7.12.71.15:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.13.135.139:6112;,WINaddr:7.13.135.139:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.8.118.161:6112;,WINaddr:7.8.118.161:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.7.6.225:6112;,WINaddr:7.7.6.225:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.14.201.162:6112;,WINaddr:7.14.201.162:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.5.36.253:6112;,WINaddr:7.5.36.253:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.11.55.164:6112;,WINaddr:7.11.55.164:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.5.100.170:6112;,WINaddr:7.5.100.170:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.5.100.207:6112;,WINaddr:7.5.100.207:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.10.231.191:6112;,WINaddr:7.10.231.191:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.8.234.24:6112;,WINaddr:7.8.234.24:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.9.77.214:6112;,WINaddr:7.9.77.214:6112;
18:25:44.40   Transport::~Connection - closing WINaddr:7.13.204.71:6112;,WINaddr:7.13.204.71:6112;
18:25:44.40   Wrote 269 bytes to network datastore login_cache.bin
18:25:44.40   Wrote 52 bytes to network datastore global_cache.bin
18:25:44.40   Wrote 46 bytes to network datastore ping_cache.bin
18:25:44.40   Datastore -- uninitialize complete
18:25:44.40   QuazalInitializer - static uninit of Quazal library
18:25:44.40   QuazalInitializer - unhooking memory 0 currently allocated, 252 allocations, total of 24256 bytes
