15:48:08.16    -- DOW2 Warnings Log --
15:48:08.16    d:\programme\steam\steamapps\common\dawn of war 2\dow2.exe started at 2009-06-14 15:48
15:48:08.16    OS NT 6.0, 4095 MB Physical Memory, 3058 Mb Physical Available, 3665 Mb Virtual Available
15:48:08.16    RUN OPTIONS: -logs 
15:48:08.16    WORKING DIR: 'd:\programme\steam\steamapps\common\dawn of war 2'
15:48:08.16    USER: 'Christopher'
15:48:08.19    MOD -- Initializing mod 'DOW2', version '1.3', locale 'english'.
15:48:08.22    APP - Multi-threading Enabled
15:48:08.22    XTHREAD: Detected 2 core(s) with 2 hardware thread(s)
15:48:08.38    NetworkManager::Create - creating network manager
15:48:11.11    Transport::Connection request to live://255.255.255.255,0.0.0.0?port=1001?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
15:48:11.11    Transport::Connection request to live://0.0.0.1,0.0.0.0?port=1000?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
15:48:11.11    Net::ThreadFunction - Entering network thread function...
15:48:11.11    MessageInternal::CreateChannel: Created channel GSTP
15:48:11.11    Session::Initialize - info, initializing session object, using threads.
15:48:11.11    Transport::Connection request to live://255.255.255.255,0.0.0.0?port=1001?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
15:48:11.11    AutomatchInternal: Instantiating
15:48:11.11    PartyInternal: Instantiating
15:48:11.11    MessageInternal::CreateChannel: Created channel PRTY
15:48:11.11    MessageInternal::CreateChannel: Created channel QCKM
15:48:11.11    Session::Initialize - info, initializing session object, using threads.
15:48:11.11    Transport::Connection request to live://255.255.255.255,0.0.0.0?port=1001?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
15:48:11.12    MessageInternal::CreateChannel: Created channel STEM
15:48:11.12    GAME -- Dawn of War 2, EXE Version: 1.3, Build DOW2.1.3.3552
15:48:11.87    ShaderDatabase : shader [DATA:Shaders\TERRAINOVERLAY.SHADER] specifies an undefined inputlayout terrainbasemesh.
15:48:11.90    VIDEO -- Driver Name = nvd3dum.dll  Desc = NVIDIA GeForce 8800 GT 
15:48:11.90    VIDEO -- Driver Vendor = 0x10DE  Device = 0x0611  SubSys = 0x11701462  Rev = 0x00A2
15:48:11.90    VIDEO -- Driver Version  Product = 0x0008  Version = 0x000F  SubVersion = 0x000B  Build = 0x2189 (8585)
15:48:11.90    VIDEO -- Driver GUID = {D7B71E3E-4551-11CF-5B56-7B3102C2C535}
15:48:14.92    VIDEO -- Detected Display Video Memory [2289 MB]
15:48:14.94    VIDEO - NVIDIA card memory, dedicated [65552 MB], system [512 MB], shared [0 MB]
15:48:14.94    VIDEO -- Dedicated Video Memory [512 MB]
15:48:14.94    VIDEO -- Graphics Card Memory [512 MB] Texture Memory Available [2269 MB].
15:48:14.95    VIDEO - Using shader profile 'sm3'
15:48:14.96    SHADER -- variable [g_bPostProcessingEnabled] declared in [effectpool.shader] but not in .fx.
15:48:14.96    SHADER -- variable [g_useTerrainLightmap] declared in [effectpool.shader] but not in .fx.
15:48:15.00    Largest sent is now 56
15:48:15.02    SHADER -- variable [textureSize] declared in [terrain_splatongeometry.shader] but not in .fx.
15:48:15.30    SHADER -- variable [dualScarTexTilingFactor] declared in [dow2_building_brick_scar_dual.shader] but not in .fx.
15:48:15.36    VIDEO -- Texture Memory Start Device Reset: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
15:48:15.43    VIDEO -- Texture Memory End Device Reset: Video  [512MB] Total [2269MB] Available [2238MB] Used [31MB].
15:48:16.86    XNetGetTitleXnAddr changed our reporting address
15:48:18.58    SOUND -- FMOD System Initializing...
15:48:18.59    SOUND -- Speaker output configuration set to Stereo
15:48:18.63    SOUND -- FMOD System Initialized on device Lautsprecher (High Definition Audio-Gert).
15:48:21.17    SOUND -- SIR Filter 1 initialized
15:48:21.17    SOUND -- SIR Filter 2 initialized
15:48:21.17    SOUND -- Initializing ...
15:48:21.18    SOUND -- 96 voices selected, using 96 LOD settings
15:48:21.24    SOUND -- Initialization completed!
15:48:21.28    GAME -- Beginning FE
15:48:21.28    starting fe
15:48:21.28    ScaleformFrontEnd - Loading Front End
15:48:23.39    starting fe done
15:48:23.39    APP -- Resetting fp control word.
15:48:23.52    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_statslevel.php?name=DOW2
15:48:23.56    LiveAccountService:OnSignInChanged, clearing profile settings.
15:48:23.56    OnLogin: no previous login, auto selecting profile not required
15:48:23.63    OnConnect: successful connection established, enabling reconnect
15:48:23.63    OnConnect: this wasnt a reconnect, no need for autologin
15:48:23.67    Profile [00090000:02d539af] selected on controller#0
15:48:23.68    LiveGetProfileSettingsAsync - setting profile settings.
15:48:42.86    PBGM Loaded in 15.559001 seconds.
15:48:43.25    GAME -- Using player profile CHRISTOPHER1-PC
15:48:51.25    FactoryT - CreateForm transition_movie
15:48:51.26    FactoryT - CreateForm main_menu
15:48:51.26    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2224MB] Used [45MB].
15:48:51.33    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2228MB] Used [41MB].
15:48:51.45    FactoryT - CreateForm news
15:48:55.20    Got XN_SYS_UI - guide enabled
15:48:58.29    LiveAccountService:OnSignInChanged, clearing profile settings.
15:48:58.29    CallManager - terminating all server calls in progress (0 in progress)
15:48:58.30    Disconnect process - nothing to do
15:48:58.34    OnConnect: connect failure
15:48:58.34    OnConnect: this wasnt a reconnect, no need for autologin
15:49:11.01    Transport::Update median kBPS [highest/current] sent = 0/0, recvd = 0/0, total = 0/0, max unsent 0, version mismatches 0 and blocked 0
15:49:11.14    XNetGetTitleXnAddr changed our reporting address
15:49:11.79    LiveAccountService:OnSignInChanged, clearing profile settings.
15:49:11.79    OnLogin: no previous login, auto selecting profile not required
15:49:11.82    OnConnect: successful connection established, enabling reconnect
15:49:11.82    OnConnect: this wasnt a reconnect, no need for autologin
15:49:11.83    Profile [00090000:030431e7] selected on controller#0
15:49:11.84    LiveGetProfileSettingsAsync - setting profile settings.
15:49:15.61    Got XN_SYS_UI - guide disabled
15:49:16.89    FactoryT - CreateForm gamehistory_tabs
15:49:16.90    FactoryT - CreateForm gamehistory_replays
15:49:17.12    GAME -- Error reading header for recorded game PLAYBACK:eas vs gaddy 1.rec
15:49:17.21    GAME -- Error reading header for recorded game PLAYBACK:eas vs gaddy 2.rec
15:49:28.11    FactoryT - CreateForm main_menu
15:49:28.11    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2152MB] Used [117MB].
15:49:28.18    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2209MB] Used [60MB].
15:49:28.19    FactoryT - CreateForm news
15:49:36.40    Created Partyinfo
15:49:36.40    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
15:49:37.35    OnServiceJoinSuccess - joined online party, server leave notification required
15:49:37.35    starting local hosting
15:49:37.35    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAHZLRFpOiI=?XnKey=Bic8u+txFfvPbRTkgsTPwQ==
15:49:37.35    ValidateCustomData: called with 101 bytes of custom data
15:49:37.35    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAHZLRFpOiI=?XnKey=Bic8u+txFfvPbRTkgsTPwQ==
15:49:37.35    PartyInternal::Process - EVENT_NEWPEER
15:49:37.35    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
15:49:37.36    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
15:49:37.36    hosting - Session is connected
15:49:37.36    hosting completed successfully
15:49:37.36    HostAsync - completed with HostResult = 0
15:49:37.38    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:49:37.38    FactoryT - CreateForm matchmaking
15:49:37.39    MessageInternal::CreateChannel: Created channel SMSG
15:49:37.39    GetMaxFrameTimeFromProfile: players=4 expected FPS=22.544947, bars=5, max avg=0.042, sd=0.003, 5 samples =  0.05 0.04 0.04 0.04 0.04
15:49:37.39    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:49:37.39    MessageInternal::CreateChannel: Created channel PPGM
15:49:37.39    FactoryT - CreateForm chat_panel
15:49:37.39    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
15:49:37.40    FactoryT - CreateForm party_panel
15:49:37.40    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:49:37.40    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
15:49:37.41    FactoryT - CreateForm hero_selection_panel
15:49:37.45    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
15:49:37.48    Hero sbps\pvp\race_marine\heroes\sm_force_commander has been selected
15:49:37.48    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:49:37.53    FactoryT - CreateForm game_options_panel
15:49:37.53    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
15:49:37.81    destLen = 270
15:49:39.05    Hero sbps\pvp\race_marine\heroes\sm_apothecary has been selected
15:49:40.05    Hero sbps\pvp\race_marine\heroes\sm_force_commander has been selected
15:49:40.82    Hero sbps\pvp\race_marine\heroes\sm_apothecary has been selected
15:49:41.70    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
15:49:41.70    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:49:42.72    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
15:49:43.75    MessageInternal::DestroyChannel: Destroyed channel SMSG
15:49:43.76    FactoryT - CreateForm main_menu
15:49:43.76    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2137MB] Used [132MB].
15:49:43.84    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2201MB] Used [68MB].
15:49:43.86    FactoryT - CreateForm news
15:49:43.86    Session is marking the local peer PeerID 1 for death
15:49:43.86    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAHZLRFpOiI=?XnKey=Bic8u+txFfvPbRTkgsTPwQ==
15:49:43.86    PartyInternal::Process - EVENT_DESTROYPEER
15:49:43.86    LeavePartyInternal - no action taken, needLeave=0
15:49:43.86    Destroyed Partyinfo
15:49:43.88    Largest received is now 9
15:49:44.55    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
15:49:44.55    RemoveAllPeers - flushing local session peer data
15:49:44.55    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
15:49:44.64    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:49:45.87    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:50:12.01    Transport::Update median kBPS [highest/current] sent = 0/0, recvd = 0/0, total = 0/0, max unsent 0, version mismatches 0 and blocked 0
15:51:10.05    Created Partyinfo
15:51:10.05    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
15:51:10.55    OnServiceJoinSuccess - joined online party, server leave notification required
15:51:10.55    starting local hosting
15:51:10.55    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAHTbEf8LBQ=?XnKey=QIzQ11pQOrc46Cu3KQb4ug==
15:51:10.55    ValidateCustomData: called with 101 bytes of custom data
15:51:10.55    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAHTbEf8LBQ=?XnKey=QIzQ11pQOrc46Cu3KQb4ug==
15:51:10.55    PartyInternal::Process - EVENT_NEWPEER
15:51:10.55    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
15:51:10.58    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
15:51:10.58    hosting - Session is connected
15:51:10.59    hosting completed successfully
15:51:10.59    HostAsync - completed with HostResult = 0
15:51:10.59    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:51:10.61    FactoryT - CreateForm matchmaking
15:51:10.61    MessageInternal::CreateChannel: Created channel SMSG
15:51:10.61    GetMaxFrameTimeFromProfile: players=4 expected FPS=22.544947, bars=5, max avg=0.042, sd=0.003, 5 samples =  0.05 0.04 0.04 0.04 0.04
15:51:10.61    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:51:10.61    FactoryT - CreateForm chat_panel
15:51:10.61    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
15:51:10.62    FactoryT - CreateForm party_panel
15:51:10.62    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:51:10.62    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
15:51:10.62    FactoryT - CreateForm hero_selection_panel
15:51:10.67    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
15:51:10.69    Hero sbps\pvp\race_marine\heroes\sm_apothecary has been selected
15:51:10.70    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:51:10.74    FactoryT - CreateForm game_options_panel
15:51:10.74    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
15:51:10.89    destLen = 270
15:51:12.19    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
15:51:12.19    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:51:12.83    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
15:51:13.01    Transport::Update median kBPS [highest/current] sent = 0/0, recvd = 0/0, total = 0/0, max unsent 0, version mismatches 0 and blocked 0
15:51:32.66    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:51:34.48    GetMaxFrameTimeFromProfile: players=2 expected FPS=37.665264, bars=5, max avg=0.023, sd=0.004, 5 samples =  0.03 0.02 0.02 0.02 0.02
15:51:37.27    QuickMatchInternal - StartPolling
15:51:37.27    Set state; QuickMatchInternal::S_Searching 
15:51:37.27    PostPollEvent - host state = QuickMatchInternal::S_Searching
15:51:37.27    Host state; QuickMatchInternal::S_Searching 
15:51:42.00    QuickMatchInternal::GetQuickMatchMapToPlay - numMaps 10  m_matchTypeID 1
15:51:42.00    QuickMatchInternal - No matches found, trying to host.
15:51:42.00    Set state; QuickMatchInternal::S_Hosting 
15:51:42.00    Created Matchinfo
15:51:42.00    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
15:51:42.00    Creation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] -
15:51:42.00    starting online hosting
15:51:42.00    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
15:51:42.00    PostPollEvent - host state = QuickMatchInternal::S_Hosting
15:51:42.00    Host state; QuickMatchInternal::S_Hosting 
15:51:42.98    OnJoinAdvertisementSuccess - joined online match, server leave notification required
15:51:43.02    starting local hosting
15:51:43.02    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=GhofLkw3Ry9O9JolJNr9sQ==
15:51:43.02    ValidateCustomData: called with 253 bytes of custom data
15:51:43.02    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - host 1
15:51:43.02    Steam ID is not registered [01100001:01b0619f]
15:51:43.02    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=GhofLkw3Ry9O9JolJNr9sQ==
15:51:43.02    AdvertisementInternal::Process - EVENT_NEWPEER
15:51:43.02    LiveOnPeerAddAsync added playerID 2533274841002471 as Local player in index 0
15:51:43.02    Registering steamID [01100001:01b0619f] with userID [00090000:030431e7]
15:51:43.02    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
15:51:43.03    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
15:51:43.03    hosting - Session is connected
15:51:43.03    Net::Session::SetHostGameStarted - session is set to SETUP.
15:51:43.03    Net::Session::SetVisible - session is set to VISIBLE.
15:51:43.03    hosting completed successfully
15:51:43.03    HostAsync - completed with HostResult = 0
15:51:43.03    AutomatchInternal::OnHostComplete - Completed Host with success=1
15:51:43.03    AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
15:51:43.03    QuickMatchInternal::OnHostComplete - Host complete.
15:51:43.03    Set state; QuickMatchInternal::S_Waiting 
15:51:43.03    PostPollEvent - host state = QuickMatchInternal::S_Waiting
15:51:43.03    Host state; QuickMatchInternal::S_Waiting 
15:51:43.03    PostPollEvent - host state = QuickMatchInternal::S_Waiting
15:51:43.03    Host state; QuickMatchInternal::S_Waiting 
15:51:43.04    destLen = 345
15:51:43.04    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:52:09.06    Largest received is now 638
15:52:09.06    Transport::Connection request to live://192.168.2.107,84.138.75.155?port=524?mac=ANaS8vcO?abOnline=Cv4LAQDXbPiHiBoAAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
15:52:09.10    Transport::Connection request to live://192.168.2.107,84.138.75.155?port=524?mac=ANaS8vcO?abOnline=Cv4LAQDXbPiHiBoAAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=GhofLkw3Ry9O9JolJNr9sQ==
15:52:09.10    Largest sent is now 61
15:52:09.11    ValidateCustomData: called with 637 bytes of custom data
15:52:09.11    Validation callback for for user [00090000:02a74b98] - steam [01100001:02ab5aec] - host 1
15:52:09.11    Steam ID is not registered [01100001:02ab5aec]
15:52:09.11    Host accepted Peer 2 into the match at address live://192.168.2.107,84.138.75.155?port=524?mac=ANaS8vcO?abOnline=Cv4LAQDXbPiHiBoAAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=GhofLkw3Ry9O9JolJNr9sQ==
15:52:09.11    AdvertisementInternal::Process - EVENT_NEWPEER
15:52:09.11    LiveOnPeerAddAsync added playerID 2533274834914200 as Remote player
15:52:09.11    Registering steamID [01100001:02ab5aec] with userID [00090000:02a74b98]
15:52:09.11    PostPollEvent - host state = QuickMatchInternal::S_Waiting
15:52:09.11    Host state; QuickMatchInternal::S_Waiting 
15:52:09.12    destLen = 364
15:52:09.13    Largest sent is now 280
15:52:09.13    Largest sent is now 541
15:52:09.54    PostStatsAsync::Initialization - Stats Upload Schema[Name:DOW2][Version:1][crc:1799561214][len:168] Record[len:68]
15:52:09.54    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_schema_id.php?name=DOW2&version=1&crc=1799561214
15:52:09.99    PostStatsAsync::WaitForGetSchema - schema is id 46
15:52:10.02    Station [0:2] acknowledged matchinfo change #21
15:52:10.02    Station [0:2] acknowledged matchinfo change #23
15:52:10.02    QuickMatchInternal::OnQMMT_StartGame_To_Everyone - Got a start game.
15:52:10.02    L0L4d1n is now muted
15:52:10.02    RankManager::GetLocalPlayerExp can't ask again yet, bailing
15:52:10.04    LiveAdvertisement::SetJoinable, match doesn't use presence, nothing to do
15:52:10.04    L0L4d1n is now muted
15:52:10.04    GetMaxFrameTimeFromProfile: players=2 expected FPS=37.665264, bars=5, max avg=0.023, sd=0.004, 5 samples =  0.03 0.02 0.02 0.02 0.02
15:52:10.04    Set state; QuickMatchInternal::S_Starting 
15:52:10.07    PostPollEvent - host state = QuickMatchInternal::S_Starting
15:52:10.07    Host state; QuickMatchInternal::S_Starting 
15:52:10.07    QuickMatchInternal - StopPolling with state=QuickMatchInternal::S_Starting
15:52:10.07    Set state; QuickMatchInternal::S_Idle 
15:52:10.07    HttpRequestAsync::Initialization - sending 68 bytes to dow2stats.relic.com///reports/post_report.php?schemaID=46
15:52:10.07    PostPollEvent - host state = QuickMatchInternal::S_Idle
15:52:10.07    Host state; QuickMatchInternal::S_Idle 
15:52:10.08    destLen = 369
15:52:11.00    destLen = 377
15:52:11.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:52:11.74    Station [0:2] acknowledged matchinfo change #26
15:52:12.01    destLen = 383
15:52:12.05    Station [0:2] acknowledged matchinfo change #27
15:52:12.33    Station [0:2] acknowledged matchinfo change #29
15:52:12.70    Station [0:2] acknowledged matchinfo change #30
15:52:14.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/1, max unsent 0, version mismatches 0 and blocked 0
15:52:16.00    LiveAdvertisement::SetJoinable, match doesn't use presence, nothing to do
15:52:16.00    Net::Session::SetHostGameStarted - session is set to INGAME.
15:52:16.00    MatchInternal::SetMatchState - state 1 - updating server
15:52:16.00    Net::Session::SetVisible - session is set to INVISIBLE.
15:52:16.00    MatchSetup: Sending start game message!
15:52:16.00    GameSetupForm - Starting game
15:52:16.00    PopulateGameInfo - random seed:[1244987536], guid:[{d1628b23-11ea-4265-ab7f-9ea6f371e2e5}], sync level:[0]
15:52:16.00    APP -- Game Start
15:52:16.00    GAME -- Ending FE
15:52:16.00    ScaleformFrontEnd - Unloading Front End
15:52:16.03    MessageInternal::DestroyChannel: Destroyed channel SMSG
15:52:16.13    MessageInternal::CreateChannel: Created channel SYNC
15:52:16.13    P2PNetworkSynchronization::RegisterPeer - info, registered local station [1].
15:52:16.13    P2PNetworkSynchronization::RegisterPeer - info, registered remote station [2].
15:52:16.13    L0L4d1n is now muted
15:52:16.13    MessageInternal::CreateChannel: Created channel GOBJ
15:52:16.13    GAME -- *** Beginning mission 2p_typhonswamp (2 Humans, 0 Computers) ***
15:52:16.13    GameObj::StartGameObj - info, network session GUID set to [{d1628b23-11ea-4265-ab7f-9ea6f371e2e5}].
15:52:16.37    GAME -- Recording game
15:52:16.42    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2156MB] Used [113MB].
15:52:16.44    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2199MB] Used [70MB].
15:52:16.45    GAME -- Precaching Action
15:52:17.07    GAME -- Loading Animators
15:52:17.31    Station [0:2] acknowledged matchinfo change #33
15:52:17.31    GameObjController - OnMatchEvent: event type 6
15:52:24.46    XSessionArbitrationRegister fine
15:52:25.09    XSessionStart fine
15:52:34.13    ImpassMap Load CRC
15:52:34.13      :  1056964608
15:52:34.13      :  1059892375
15:52:34.13      :  1053609165
15:52:34.13      :  0
15:52:34.13      g: 425632575
15:52:34.13      f: 425632575
15:52:35.33    MessageInternal::CreateChannel: Created channel GMCC
15:52:35.64    MessageInternal::CreateChannel: Created channel MODM
15:52:38.04    GAME -- Loading completed (22 seconds)
15:52:38.04    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2215MB] Used [54MB].
15:52:38.12    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2215MB] Used [54MB].
15:52:38.12    SIM -- Setting SyncErrorChecking level to Low
15:52:38.17    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:40.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:42.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:44.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:52:44.00    PeerID 2 is CONNECTED and has 106 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 20 percent, avg packet size is 166
15:52:44.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:46.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:48.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:50.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:52.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:54.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:56.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:52:58.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:00.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:02.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:04.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:06.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:08.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:10.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:12.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:12.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:53:14.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:15.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
15:53:16.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:18.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:20.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:50606567, Orkampel]" finished loading with checksum [3236740499].
15:53:20.12    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:44518296, L0L4d1n]" finished loading with checksum [3236740499].
15:53:20.13    PerformanceRecorder::StartRecording for game size 2
15:53:20.13    GAME -- Starting mission...
15:53:20.90    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
15:53:21.42    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
15:53:22.33    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [8] frames.
15:53:24.07    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [16] frames.
15:53:25.39    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
15:53:25.90    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
15:53:45.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:53:45.02    PeerID 2 is CONNECTED and has 330 message receipts and 2 messages pending receipt, highwater out of sequence is 0, avg compression is 10 percent, avg packet size is 56
15:53:55.91    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:54:13.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:54:14.88    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
15:54:16.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/1, max unsent 0, version mismatches 0 and blocked 0
15:54:46.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:54:46.01    PeerID 2 is CONNECTED and has 939 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 6 percent, avg packet size is 84
15:55:00.08    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:55:10.91    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:55:14.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:55:17.02    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/1, max unsent 0, version mismatches 0 and blocked 0
15:55:47.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:55:47.02    PeerID 2 is CONNECTED and has 1549 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 8 percent, avg packet size is 78
15:55:47.67    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:55:55.75    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:56:15.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:56:18.02    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/1, max unsent 0, version mismatches 0 and blocked 0
15:56:27.34    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:56:40.44    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:56:48.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:56:48.00    PeerID 2 is CONNECTED and has 2160 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 7 percent, avg packet size is 82
15:56:50.01    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:57:01.75    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:57:16.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:57:19.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/1, max unsent 0, version mismatches 0 and blocked 0
15:57:29.79    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:57:40.31    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:57:49.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:57:49.02    PeerID 2 is CONNECTED and has 2770 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 14 percent, avg packet size is 105
15:57:59.31    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:58:15.94    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:58:17.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:58:20.02    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/1, max unsent 0, version mismatches 0 and blocked 0
15:58:29.31    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:58:45.41    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:58:50.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:58:50.01    PeerID 2 is CONNECTED and has 3381 message receipts and 2 messages pending receipt, highwater out of sequence is 0, avg compression is 4 percent, avg packet size is 90
15:58:58.82    LagArbitrator - station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000001, pid 589824:50606567, Orkampel]]
15:59:18.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
15:59:21.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/1, total = 5/1, max unsent 0, version mismatches 0 and blocked 0
15:59:32.65    LiveTransport::Update unable to determined XNADDR for local peer
15:59:32.68    LiveTransport::Update unable to determined XNADDR for local peer
15:59:32.73    LiveTransport::Update unable to determined XNADDR for local peer
15:59:32.97    Session - XSocketSendTo failed, unreachable, closing connections
15:59:32.97    Session - XSocketSendTo failed, unreachable, closing connections
15:59:32.97    LiveAccountService:OnSignInChanged, clearing profile settings.
15:59:32.99    Closed connection by remote request for PeerID 2 at live://192.168.2.107,84.138.75.155?port=524?mac=ANaS8vcO?abOnline=Cv4LAQDXbPiHiBoAAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=GhofLkw3Ry9O9JolJNr9sQ==
15:59:32.99    Session - XSocketSendTo failed, unreachable, closing connections
15:59:32.99    Session is marking the local peer PeerID 1 for death
15:59:32.99    Session is marking PeerID 2 for death
15:59:32.99    Session is marking the local peer PeerID 1 for death
15:59:32.99    Closed connection for PeerID 2 at live://192.168.2.107,84.138.75.155?port=524?mac=ANaS8vcO?abOnline=Cv4LAQDXbPiHiBoAAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=GhofLkw3Ry9O9JolJNr9sQ==
15:59:32.99    AdvertisementInternal::Process - EVENT_DESTROYPEER
15:59:32.99    Removing steamID [01100001:02ab5aec] with userID [00090000:02a74b98]
15:59:32.99    GameObjController - OnMatchEvent: event type 1
15:59:32.99    GameObj::OnRemoteStationDisconnected - info, remote station [2] was disconnected, disconnect reason code given [2], AI simulated players will migrate to [1].
15:59:32.99    GameObj::OnRemoteStationDisconnected - info, remote station [2] is disconnected, disconnection reason code [2].
15:59:32.99    P2PNetworkSynchronization::OnDestroyedPeerEvent - info, drop event received for remote station [2].
15:59:32.99    OnDestroyedPeerEvent - calling RemovePeerFromSync.
15:59:32.99    P2PNetworkSynchronization::StartConsolidation - info, starting consolidation for station, station id= [2].
15:59:32.99    P2PNetworkSynchronization::Vote - info, voting for consolidation, station id = [2], frame = [3675]
15:59:32.99    Session::SendData local peer is marked for death, not sending
15:59:32.99    P2PNetworkSynchronization::CheckConsolidation - info, consolidation for station [2] completed.
15:59:32.99    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAQjld9N35E=?XnKey=GhofLkw3Ry9O9JolJNr9sQ==
15:59:32.99    AdvertisementInternal::Process - EVENT_DESTROYPEER
15:59:32.99    Removing steamID [01100001:01b0619f] with userID [00090000:030431e7]
15:59:32.99    GameObjController - OnMatchEvent: event type 1
15:59:32.99    P2PNetworkSynchronization::OnDestroyedPeerEvent - info, drop event received for local station [1].
15:59:32.99    LeaveMatchInternal - no action taken, needLeave=0, service=0
15:59:32.99    Destroyed Matchinfo
15:59:32.99    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQC5WyAZJh0AAAAA+wIAAAA=?XnKid=gAHTbEf8LBQ=?XnKey=QIzQ11pQOrc46Cu3KQb4ug==
15:59:32.99    PartyInternal::Process - EVENT_DESTROYPEER
15:59:32.99    LeavePartyInternal - no action taken, needLeave=0
15:59:32.99    Destroyed Partyinfo
15:59:33.03    OnConnect: connect failure
15:59:33.03    OnConnect: this wasnt a reconnect, no need for autologin
15:59:33.03    APP -- Game Stop
15:59:33.03    GameApp::TransitionGameStop
15:59:33.03    GameApp::TransitionQuitCommon
15:59:33.03    Unable to mute opposing team, could not get the MatchInfo
15:59:33.03    PerformanceRecorder: Updating profile history
15:59:33.03    GetMaxFrameTimeFromProfile: players=2 expected FPS=33.358208, bars=5, max avg=0.025, sd=0.005, 5 samples =  0.03 0.03 0.02 0.02 0.02
15:59:33.03    PerformanceRecorder::EndRecording - game size=2, max average=0.031903, worst frame=0.029978
15:59:33.03     Recording: No [2 players]

15:59:33.03     Total frame time: 12.74 sec

15:59:33.03     Total frame count: 593

15:59:33.03     Max/Avg: 0.03, 0.02 sec (fps=31.35, 45.10) (17 samples)

15:59:33.03     Bars: 5

15:59:33.03    Profile Max Performance[2 players] =  0.03 0.03 0.02 0.02 0.02
15:59:33.03    Profile Avg Performance[2 players] =  0.02 0.02 0.02 0.02 0.02
15:59:33.04    Session - XSocketSendTo failed, unreachable, closing connections
15:59:33.04    VoiceInternal::UnregisterRemoteTalker remote talker 2533274834914200 doesn't exist, bailing
15:59:33.04    LiveOnPeerRemoveAsync removed playerID 2533274834914200 as Remote player
15:59:33.04    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2111MB] Used [158MB].
15:59:33.15    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
15:59:33.16    GAME -- Beginning FE
15:59:33.16    GameObj::ShutdownGameObj
15:59:33.21    GAME -- Ending mission - 'Sign In Change'
15:59:33.26    LiveCall: Session Delete failed : ([0x800704cd] - )
15:59:33.26    LiveCall: Session Delete failed : ([0x800704cd] - )
15:59:33.26    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
15:59:33.26    RemoveAllPeers - flushing local session peer data
15:59:33.26    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
15:59:33.26    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
15:59:33.26    PeerRemoveAll - flushing local session peer data
15:59:33.26    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
15:59:33.46    MessageInternal::DestroyChannel: Destroyed channel MODM
15:59:34.21    SOUND -- Flushing cache ...
15:59:34.22    SOUND -- Flush complete!
15:59:34.22    CRCBlockManager Max Count: 13
15:59:34.22    MessageInternal::DestroyChannel: Destroyed channel GMCC
15:59:34.23    MessageInternal::DestroyChannel: Destroyed channel SYNC
15:59:34.35    ScaleformFrontEnd::Process - preloading task complete
15:59:34.35    starting fe
15:59:34.35    ScaleformFrontEnd - Loading Front End
15:59:37.49    LiveTransport::Update unable to determined XNADDR for local peer
15:59:37.51    LiveTransport::Update unable to determined XNADDR for local peer
15:59:37.59    LiveTransport::Update unable to determined XNADDR for local peer
15:59:37.63    LiveTransport::Update unable to determined XNADDR for local peer
15:59:38.69    starting fe done
15:59:38.69    ScaleformFrontEnd::Process - threaded loading task complete
15:59:38.78    FactoryT - CreateForm transition_movie
15:59:38.79    FactoryT - CreateForm main_menu
15:59:38.79    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
15:59:38.84    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
15:59:38.88    FactoryT - CreateForm news
15:59:42.26    Got XN_SYS_UI - guide enabled
15:59:50.88    XNetGetTitleXnAddr changed our reporting address
15:59:51.53    LiveAccountService:OnSignInChanged, clearing profile settings.
15:59:51.53    Updating local user id
15:59:51.56    OnConnect: successful connection established, enabling reconnect
15:59:51.56    OnConnect: this wasnt a reconnect, no need for autologin
15:59:53.85    Got XN_SYS_UI - guide disabled
16:00:22.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:01:23.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:02:24.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:03:25.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:04:26.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:05:27.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:06:28.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:07:29.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 1/0, total = 5/0, max unsent 0, version mismatches 0 and blocked 0
16:07:54.26    VIDEO -- Texture Memory Start Device Reset: Video  [512MB] Total [2269MB] Available [2269MB] Used [0MB].
16:07:54.33    VIDEO -- Texture Memory End Device Reset: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:07:57.65    Got XN_SYS_UI - guide enabled
16:08:06.67    Got XN_SYS_UI - guide disabled
16:08:08.52    Created Partyinfo
16:08:08.52    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:08:09.02    OnServiceJoinSuccess - joined online party, server leave notification required
16:08:09.02    starting local hosting
16:08:09.02    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAF2o2JIPTI=?XnKey=wAMjGrTGmZfMj8spbzOJ7w==
16:08:09.02    ValidateCustomData: called with 101 bytes of custom data
16:08:09.02    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAF2o2JIPTI=?XnKey=wAMjGrTGmZfMj8spbzOJ7w==
16:08:09.02    PartyInternal::Process - EVENT_NEWPEER
16:08:09.02    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:08:09.03    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:08:09.03    hosting - Session is connected
16:08:09.04    hosting completed successfully
16:08:09.04    HostAsync - completed with HostResult = 0
16:08:09.05    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:08:09.06    FactoryT - CreateForm matchmaking
16:08:09.06    MessageInternal::CreateChannel: Created channel SMSG
16:08:09.09    FactoryT - CreateForm chat_panel
16:08:09.09    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
16:08:09.10    FactoryT - CreateForm party_panel
16:08:09.10    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:08:09.10    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
16:08:09.11    FactoryT - CreateForm hero_selection_panel
16:08:09.14    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
16:08:09.17    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:08:09.17    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:08:09.22    FactoryT - CreateForm game_options_panel
16:08:09.22    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
16:08:09.46    destLen = 244
16:08:10.60    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:08:11.50    QuickMatchInternal - StartPolling
16:08:11.50    Set state; QuickMatchInternal::S_Searching 
16:08:11.51    PostPollEvent - host state = QuickMatchInternal::S_Searching
16:08:11.51    Host state; QuickMatchInternal::S_Searching 
16:08:16.00    QuickMatchInternal - Found a match, trying to join.
16:08:16.00    Set state; QuickMatchInternal::S_Joining 
16:08:16.00    JoinAsync: Starting AsyncJob...
16:08:16.00    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:08:16.00    Created Matchinfo
16:08:16.00    PostPollEvent - host state = QuickMatchInternal::S_Joining
16:08:16.00    Host state; QuickMatchInternal::S_Joining 
16:08:16.03    OnlineJoinAsync success
16:08:16.03    OnJoinAdvertisementSuccess - joined online match, server leave notification required
16:08:16.04    Creation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] -
16:08:16.04    Transport::Connection request to live://192.168.1.33,88.14.153.146?port=16681?mac=AOD5eXjB?abOnline=Cv4zAQDDCSzG4SMAAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:08:16.04    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:08:16.04    Session::Connect host address live://192.168.1.33,88.14.153.146?port=16681?mac=AOD5eXjB?abOnline=Cv4zAQDDCSzG4SMAAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:08:16.06    Largest sent is now 611
16:08:16.61    Session - highest peerID now : 3
16:08:16.61    Session::PollTransportEvents AddPeerMessage recv'd for existing pending peer, the local peer
16:08:16.61    Session::PollTransportEvents AddPeerMessage recv'd for existing pending peer, the host
16:08:16.61    ValidateCustomData: called with 497 bytes of custom data
16:08:16.61    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - host 0
16:08:16.61    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - we are not the host, bailing.
16:08:16.61    Client accepted Peer 2 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:08:16.61    AdvertisementInternal::Process - EVENT_NEWPEER
16:08:16.61    LiveOnPeerAddAsync added playerID 2533274841002471 as Local player in index 0
16:08:16.61    Registering steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:08:16.61    ValidateCustomData: called with 433 bytes of custom data
16:08:16.61    Validation callback for for user [00090000:02e80795] - steam [01100001:02da072f] - host 0
16:08:16.61    Validation callback for for user [00090000:02e80795] - steam [01100001:02da072f] - we are not the host, bailing.
16:08:16.61    Client accepted Peer 1 into the match at address live://192.168.1.33,88.14.153.146?port=16681?mac=AOD5eXjB?abOnline=Cv4zAQDDCSzG4SMAAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:08:16.61    AdvertisementInternal::Process - EVENT_NEWPEER
16:08:16.61    LiveOnPeerAddAsync added playerID 2533274839156629 as Remote player
16:08:16.61    Registering steamID [01100001:02da072f] with userID [00090000:02e80795]
16:08:16.63    Accepted matchInfo updated 21 from host
16:08:16.63    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:08:16.63    JoinAsync - got operation info 0:SessionOperationInfo::SUCCESS
16:08:16.64    JoinAsync - completed with JoinResult = 0:JoinEvent::R_Success
16:08:16.64    AutomatchInternal::OnJoinComplete - Completed Join with success=1
16:08:16.64    AutomatchInternal::OnJoinComplete - automatcher is no longer active - ignoring
16:08:16.64    OnJoinComplete - join complete.
16:08:16.64    Set state; QuickMatchInternal::S_Waiting 
16:08:16.64    JoinAsync: AsyncJob Complete...
16:08:16.64    PostPollEvent - host state = QuickMatchInternal::S_Waiting
16:08:16.64    Host state; QuickMatchInternal::S_Waiting 
16:08:16.64    PostPollEvent - host state = QuickMatchInternal::S_Waiting
16:08:16.64    Host state; QuickMatchInternal::S_Waiting 
16:08:16.66    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:08:16.66    PeerID 1 is CONNECTED and has 0 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 32 percent, avg packet size is 538
16:08:16.66    Accepted matchInfo updated 23 from host
16:08:16.90    Accepted matchInfo updated 24 from host
16:08:16.92    Accepted matchInfo updated 26 from host
16:08:17.04    PostStatsAsync::Initialization - Stats Upload Schema[Name:DOW2][Version:1][crc:1799561214][len:168] Record[len:68]
16:08:17.04    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_schema_id.php?name=DOW2&version=1&crc=1799561214
16:08:17.16    QuickMatchInternal::OnQMMT_StartGame_To_Everyone - Got a start game.
16:08:17.16    francescodi is now muted
16:08:17.16    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:08:17.17    francescodi is now muted
16:08:17.17    GetMaxFrameTimeFromProfile: players=2 expected FPS=33.358208, bars=5, max avg=0.025, sd=0.005, 5 samples =  0.03 0.03 0.02 0.02 0.02
16:08:17.17    Set state; QuickMatchInternal::S_Starting 
16:08:17.17    PostPollEvent - host state = QuickMatchInternal::S_Starting
16:08:17.17    Host state; QuickMatchInternal::S_Starting 
16:08:17.17    QuickMatchInternal - StopPolling with state=QuickMatchInternal::S_Starting
16:08:17.17    Set state; QuickMatchInternal::S_Idle 
16:08:17.19    Accepted matchInfo updated 29 from host
16:08:17.19    LiveAdvertisement::SetJoinable, match doesn't use presence, nothing to do
16:08:17.19    PostPollEvent - host state = QuickMatchInternal::S_Idle
16:08:17.19    Host state; QuickMatchInternal::S_Idle 
16:08:17.42    Accepted matchInfo updated 32 from host
16:08:17.49    SMT_UpdateCountDown_To_Everyone
16:08:17.50    PostStatsAsync::WaitForGetSchema - schema is id 46
16:08:17.52    HttpRequestAsync::Initialization - sending 68 bytes to dow2stats.relic.com///reports/post_report.php?schemaID=46
16:08:18.49    SMT_UpdateCountDown_To_Everyone
16:08:19.51    SMT_UpdateCountDown_To_Everyone
16:08:20.50    SMT_UpdateCountDown_To_Everyone
16:08:21.50    SMT_UpdateCountDown_To_Everyone
16:08:22.51    SMT_UpdateCountDown_To_Everyone
16:08:22.51    SMT_StartGame_To_Everyone - received
16:08:22.51    GameSetupForm - Starting game
16:08:22.51    PopulateGameInfo - random seed:[1244988508], guid:[{b1f36d02-83c5-445c-95aa-11c62a76a64f}], sync level:[0]
16:08:22.51    APP -- Game Start
16:08:22.51    GAME -- Ending FE
16:08:22.51    ScaleformFrontEnd - Unloading Front End
16:08:22.54    MessageInternal::DestroyChannel: Destroyed channel SMSG
16:08:22.65    MessageInternal::CreateChannel: Created channel SYNC
16:08:22.65    P2PNetworkSynchronization::RegisterPeer - info, registered remote station [1].
16:08:22.65    P2PNetworkSynchronization::RegisterPeer - info, registered local station [2].
16:08:22.65    francescodi is now muted
16:08:22.65    MessageInternal::CreateChannel: Channel GOBJ already exists
16:08:22.65    GAME -- *** Beginning mission 1v1typhonlowlands (2 Humans, 0 Computers) ***
16:08:22.65    GameObj::StartGameObj - info, network session GUID set to [{b1f36d02-83c5-445c-95aa-11c62a76a64f}].
16:08:22.89    GAME -- Recording game
16:08:22.94    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2187MB] Used [82MB].
16:08:22.98    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2231MB] Used [38MB].
16:08:23.00    GAME -- Precaching Action
16:08:23.12    Accepted matchInfo updated 35 from host
16:08:23.12    AutomatchInternal::OnStartComplete - detected successful game start
16:08:23.12    GameObjController - OnMatchEvent: event type 4
16:08:23.62    GAME -- Loading Animators
16:08:23.87    XSessionArbitrationRegister fine
16:08:24.38    XSessionStart fine
16:08:30.03    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:08:32.61    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:48760725, francescodi]" finished loading with checksum [2044122941].
16:08:34.49    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:48760725, francescodi]" finished loading with checksum [2044122941].
16:08:36.38    ImpassMap Load CRC
16:08:36.38      :  1056964608
16:08:36.38      :  1059892375
16:08:36.38      :  1053609165
16:08:36.38      :  0
16:08:36.38      g: 425632575
16:08:36.38      f: 425632575
16:08:36.50    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:48760725, francescodi]" finished loading with checksum [2044122941].
16:08:37.33    MessageInternal::CreateChannel: Created channel GMCC
16:08:37.62    MessageInternal::CreateChannel: Created channel MODM
16:08:38.51    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:48760725, francescodi]" finished loading with checksum [2044122941].
16:08:39.80    GAME -- Loading completed (17 seconds)
16:08:39.80    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:08:39.87    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:08:39.87    SIM -- Setting SyncErrorChecking level to Low
16:08:39.89    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [2044122941].
16:08:39.92    PerformanceRecorder::StartRecording for game size 2
16:08:39.92    GAME -- Starting mission...
16:08:40.02    Re-winding a compressed stream for file 'sound:wav\ambiences\ambiences_streamed\x_world_amb_rain_thunder\x_world_amb_soft_rain_01.fsb'.  Expensive operation
16:08:40.60    LagArbitrator - station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]]
16:09:10.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:09:17.01    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:09:17.01    PeerID 1 is CONNECTED and has 446 message receipts and 2 messages pending receipt, highwater out of sequence is 0, avg compression is 8 percent, avg packet size is 85
16:09:31.02    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:10:11.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:10:18.02    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:10:18.02    PeerID 1 is CONNECTED and has 1056 message receipts and 2 messages pending receipt, highwater out of sequence is 0, avg compression is 8 percent, avg packet size is 82
16:10:32.00    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:11:12.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:11:19.01    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:11:19.01    PeerID 1 is CONNECTED and has 1666 message receipts and 2 messages pending receipt, highwater out of sequence is 0, avg compression is 8 percent, avg packet size is 82
16:11:33.00    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:11:58.65    Closed connection by remote request for PeerID 1 at live://192.168.1.33,88.14.153.146?port=16681?mac=AOD5eXjB?abOnline=Cv4zAQDDCSzG4SMAAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:11:58.68    Session::ProcessPeerMessages received RemovePeerMessage for Peer 1
16:11:58.68    Session::ProcessPeerMessages LocalPeer is marking PeerID 1 for death on instruction from Host
16:11:58.68    AdvertisementInternal::Process - EVENT_HOSTMIGRATION
16:11:58.68    MatchInternal::OnHostMigration - Hosting has migrated to us, updating match info
16:11:58.68    Net::Session::SetVisible - session is set to INVISIBLE.
16:11:58.68    GameObjController - OnMatchEvent: event type 5
16:11:58.68    Closed connection for PeerID 1 at live://192.168.1.33,88.14.153.146?port=16681?mac=AOD5eXjB?abOnline=Cv4zAQDDCSzG4SMAAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:11:58.68    AdvertisementInternal::Process - EVENT_DESTROYPEER
16:11:58.68    Removing steamID [01100001:02da072f] with userID [00090000:02e80795]
16:11:58.68    GameObjController - OnMatchEvent: event type 1
16:11:58.68    GameObj::OnRemoteStationDisconnected - info, remote station [1] was disconnected, disconnect reason code given [999], AI simulated players will migrate to [2].
16:11:58.68    GameObj::OnRemoteStationDisconnected - info, remote station [1] is disconnected, disconnection reason code [999].
16:11:58.68    P2PNetworkSynchronization::OnDestroyedPeerEvent - info, drop event received for remote station [1].
16:11:58.68    OnDestroyedPeerEvent - calling RemovePeerFromSync.
16:11:58.68    P2PNetworkSynchronization::StartConsolidation - info, starting consolidation for station, station id= [1].
16:11:58.68    P2PNetworkSynchronization::Vote - info, voting for consolidation, station id = [1], frame = [1984]
16:11:58.68    P2PNetworkSynchronization::CheckConsolidation - info, consolidation for station [1] completed.
16:11:58.68    GameObjController - OnMatchEvent: event type 4
16:11:58.69    LiveOnPeerRemoveAsync removed playerID 2533274839156629 as Remote player
16:11:58.91    P2PNetworkSynchronization::GetSyncCommand - info, peer[1] is being removed.
16:11:58.91    GameObj::SchedulePeerForDestruction - info, frame [1984], peer for station [1] scheduled for destruction on frame 1986.
16:11:58.91    GAME -- Frame 1984 - SchedulePeerForDestruction - peer 1000 scheduledfor destruction
16:11:59.06    GameObj - AI Simulation for player [0] on team [0] migrated to local station, id= [2].
16:11:59.06    GAME -- Frame 1986 - SimKillPlayer - Destroying SimPlayer 1000
16:11:59.06    MOD -- Player francescodi has been killed (frame 1986)
16:11:59.06    MOD -- Game Over at frame 1986
16:11:59.10    PartyProgresser PrintStatus size [1]
16:11:59.10    PartyProgresser Status user[[00090000:030431e7]], status[0]
16:11:59.10    ReportMatchStats - SimID:1000, raceID:4, teamID:0, uid:589824:48760725, result:0:PS_DISCONNECTED
16:11:59.10    CreateSessionStats for userID 2533274839156629 on teamID 0
16:11:59.10    LiveReportStats reporting 6 views for userID 2533274839156629
16:11:59.10    ReportMatchStats - SimID:1001, raceID:2, teamID:1, uid:589824:50606567, result:5:PS_WON
16:11:59.10    CreateSessionStats for userID 2533274841002471 on teamID 1
16:11:59.10    LiveReportStats reporting 6 views for userID 2533274841002471
16:11:59.10    ReportMatchStats - reporting normal game results for match [00000000:c6456bac]
16:11:59.10    ReportSimStats - storing simulation results for match 0:3326438316
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_synapse] does not have localized name.
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_marine\sm_hero_xp_modifier] does not have localized name.
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_hq_reinforce] does not have localized name.
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_ripper_reinforce] does not have localized name.
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_synapse_remove] does not have localized name.
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_marine\sm_requisition_ticker] does not have localized name.
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_marine\sm_hero_xp_modifier] does not have localized name.
16:11:59.10    GameApp::ReportSimStats - warning, [ability\pvp\race_marine\sm_requisition_ticker] does not have localized name.
16:11:59.10    PartyProgresser::HandleCountdownInfo value [10]
16:11:59.11    PostStatsAsync::Initialization - Stats Upload Schema[Name:DOW2][Version:1][crc:2198648058][len:4673] Record[len:7899]
16:11:59.13    LiveReportStats completed fine
16:11:59.13    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_schema_id.php?name=DOW2&version=1&crc=2198648058
16:11:59.14    LiveReportStats completed fine
16:11:59.16    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQWPTevDr4=?XnKey=nIwbhk3lEGf39npAfuBcxw==
16:11:59.16    Closed connection for PeerID 2 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQV93hB7KU=?XnKey=2jVJFgDSxgxzHCPomoc31g==
16:11:59.16    LiveOnHostMigrationAsync HOST completed
16:11:59.16    Transport::Close - Requested Disconnect for connectionID 9 with no connection
16:11:59.17    Transport::Close - Requested Disconnect for connectionID 9 with no event handlers.
16:11:59.71    PostStatsAsync::WaitForGetSchema - schema is id 45
16:11:59.74    HttpRequestAsync::Initialization - sending 7899 bytes to dow2stats.relic.com///reports/post_report.php?schemaID=45
16:11:59.82    LiveReportResults fine
16:12:00.00    PartyProgresser::HandleCountdownInfo value [9]
16:12:00.00    GameObjController - OnMatchEvent: event type 4
16:12:01.01    PartyProgresser::HandleCountdownInfo value [8]
16:12:01.01    GameObjController - OnMatchEvent: event type 4
16:12:01.58    ReportStats - already reported or no need to report for match [00000000:c6456bac]
16:12:01.58    APP -- Game Stop
16:12:01.58    GameApp::TransitionGameStop
16:12:01.58    GameApp::TransitionQuitCommon
16:12:01.58    PerformanceRecorder: Updating profile history
16:12:01.58    GetMaxFrameTimeFromProfile: players=2 expected FPS=33.363770, bars=5, max avg=0.025, sd=0.005, 5 samples =  0.02 0.03 0.03 0.02 0.02
16:12:01.58    PerformanceRecorder::EndRecording - game size=2, max average=0.020832, worst frame=0.029973
16:12:01.58     Recording: No [2 players]

16:12:01.58     Total frame time: 1.56 sec

16:12:01.58     Total frame count: 111

16:12:01.58     Max/Avg: 0.02, 0.02 sec (fps=48.00, 56.00) (9 samples)

16:12:01.58     Bars: 5

16:12:01.58    Profile Max Performance[2 players] =  0.02 0.03 0.03 0.02 0.02
16:12:01.58    Profile Avg Performance[2 players] =  0.02 0.02 0.02 0.02 0.02
16:12:01.58    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2112MB] Used [157MB].
16:12:01.68    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:12:01.68    GAME -- Beginning FE
16:12:01.68    GameObj::ShutdownGameObj
16:12:01.71    GAME -- Ending mission - 'Game over'
16:12:01.89    MessageInternal::DestroyChannel: Destroyed channel MODM
16:12:02.14    SOUND -- Flushing cache ...
16:12:02.17    SOUND -- Flush complete!
16:12:02.17    CRCBlockManager Max Count: 13
16:12:02.17    MessageInternal::DestroyChannel: Destroyed channel GMCC
16:12:02.17    MessageInternal::DestroyChannel: Destroyed channel SYNC
16:12:02.31    ScaleformFrontEnd::Process - preloading task complete
16:12:02.31    starting fe
16:12:02.31    ScaleformFrontEnd - Loading Front End
16:12:06.65    starting fe done
16:12:06.65    ScaleformFrontEnd::Process - threaded loading task complete
16:12:06.74    FactoryT - CreateForm transition_movie
16:12:06.77    FactoryT - CreateForm mp_postgame
16:12:06.77    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:12:06.83    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:12:06.83    PartyProgresser::SendArriveAtPostgameMessage partyUp[2]
16:12:06.83    PostGameStatsForm::InvokeSetPlayerStatus
16:12:06.83    PostGameStatsForm::InvokeSetPlayerStatus - 2 args
16:12:06.83    PostGameStatsForm::InvokeSetPartyIcon
16:12:06.84    FactoryT - CreateForm chat_panel
16:12:06.84    FactoryT - CreateForm rank_message_box
16:12:11.05    FactoryT - CreateForm player_stats_frame
16:12:11.06    FactoryT - CreateForm gamehistory_stats
16:12:13.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:12:20.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:12:22.33    FactoryT - CreateForm player_stats_frame
16:12:22.34    FactoryT - CreateForm gamehistory_stats
16:12:34.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:12:41.48    FactoryT - CreateForm player_stats_frame
16:12:41.49    FactoryT - CreateForm gamehistory_stats
16:12:59.59    Calling disconnect...
16:12:59.59    Session is marking the local peer PeerID 1 for death
16:12:59.59    Session is marking the local peer PeerID 2 for death
16:12:59.59    Closed connection for PeerID 2 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQWPTevDr4=?XnKey=nIwbhk3lEGf39npAfuBcxw==
16:12:59.59    AdvertisementInternal::Process - EVENT_DESTROYPEER
16:12:59.59    Removing steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:12:59.59    LeaveMatchInternal - no action taken, needLeave=0, service=0
16:12:59.59    Destroyed Matchinfo
16:12:59.59    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAF2o2JIPTI=?XnKey=wAMjGrTGmZfMj8spbzOJ7w==
16:12:59.59    PartyInternal::Process - EVENT_DESTROYPEER
16:12:59.59    LeavePartyInternal - no action taken, needLeave=0
16:12:59.59    Destroyed Partyinfo
16:12:59.59    LiveOnPeerRemoveAsync removed playerID 2533274841002471 as Local player in index 0
16:13:00.05    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:13:00.05    RemoveAllPeers - flushing local session peer data
16:13:00.05    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
16:13:00.52    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:13:00.52    PeerRemoveAll - flushing local session peer data
16:13:00.52    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
16:13:00.52    Created Partyinfo
16:13:00.52    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:13:01.00    OnServiceJoinSuccess - joined online party, server leave notification required
16:13:01.00    starting local hosting
16:13:01.00    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAFCKrrcNZo=?XnKey=chqZK+/WMvCL1rO5Bvdqkw==
16:13:01.00    ValidateCustomData: called with 101 bytes of custom data
16:13:01.00    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAFCKrrcNZo=?XnKey=chqZK+/WMvCL1rO5Bvdqkw==
16:13:01.00    PartyInternal::Process - EVENT_NEWPEER
16:13:01.00    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:13:01.01    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:13:01.01    hosting - Session is connected
16:13:01.01    hosting completed successfully
16:13:01.01    HostAsync - completed with HostResult = 0
16:13:01.02    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:01.03    FactoryT - CreateForm matchmaking
16:13:01.03    MessageInternal::CreateChannel: Created channel SMSG
16:13:01.03    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:01.03    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:13:01.03    FactoryT - CreateForm chat_panel
16:13:01.03    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
16:13:01.04    FactoryT - CreateForm party_panel
16:13:01.04    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:01.04    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
16:13:01.05    FactoryT - CreateForm hero_selection_panel
16:13:01.10    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
16:13:01.12    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:13:01.13    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:01.17    FactoryT - CreateForm game_options_panel
16:13:01.17    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
16:13:01.46    destLen = 269
16:13:02.71    MessageInternal::DestroyChannel: Destroyed channel SMSG
16:13:02.72    FactoryT - CreateForm main_menu
16:13:02.72    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2173MB] Used [96MB].
16:13:02.77    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2231MB] Used [38MB].
16:13:02.78    FactoryT - CreateForm news
16:13:02.84    Session is marking the local peer PeerID 1 for death
16:13:02.84    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAFCKrrcNZo=?XnKey=chqZK+/WMvCL1rO5Bvdqkw==
16:13:02.84    PartyInternal::Process - EVENT_DESTROYPEER
16:13:02.84    LeavePartyInternal - no action taken, needLeave=0
16:13:02.84    Destroyed Partyinfo
16:13:03.52    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:13:03.52    RemoveAllPeers - flushing local session peer data
16:13:03.52    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
16:13:03.73    FactoryT - CreateForm options_form
16:13:08.75    FactoryT - CreateForm main_menu
16:13:08.75    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2185MB] Used [84MB].
16:13:08.79    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2238MB] Used [31MB].
16:13:08.80    FactoryT - CreateForm news
16:13:12.40    FactoryT - CreateForm options_form
16:13:23.00    FactoryT - CreateForm main_menu
16:13:23.00    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2185MB] Used [84MB].
16:13:23.02    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2238MB] Used [31MB].
16:13:23.04    FactoryT - CreateForm news
16:13:24.89    Created Partyinfo
16:13:24.89    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:13:25.40    OnServiceJoinSuccess - joined online party, server leave notification required
16:13:25.40    starting local hosting
16:13:25.40    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAGEYry3ro0=?XnKey=FSTxsKXIbsXV5Epi3HCM1Q==
16:13:25.40    ValidateCustomData: called with 101 bytes of custom data
16:13:25.40    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAGEYry3ro0=?XnKey=FSTxsKXIbsXV5Epi3HCM1Q==
16:13:25.40    PartyInternal::Process - EVENT_NEWPEER
16:13:25.40    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:13:25.41    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:13:25.41    hosting - Session is connected
16:13:25.42    hosting completed successfully
16:13:25.42    HostAsync - completed with HostResult = 0
16:13:25.43    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:13:25.45    FactoryT - CreateForm matchmaking
16:13:25.45    MessageInternal::CreateChannel: Created channel SMSG
16:13:25.45    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:25.45    FactoryT - CreateForm chat_panel
16:13:25.45    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
16:13:25.46    FactoryT - CreateForm party_panel
16:13:25.46    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:25.46    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
16:13:25.46    FactoryT - CreateForm hero_selection_panel
16:13:25.51    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
16:13:25.53    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:13:25.53    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:25.58    FactoryT - CreateForm game_options_panel
16:13:25.58    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
16:13:25.72    destLen = 269
16:13:27.35    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:35.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:13:35.73    VIDEO -- Texture Memory Start Device Reset: Video  [512MB] Total [2269MB] Available [2269MB] Used [0MB].
16:13:35.79    VIDEO -- Texture Memory End Device Reset: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:13:39.25    QuickMatchInternal - StartPolling
16:13:39.25    Set state; QuickMatchInternal::S_Searching 
16:13:39.25    PostPollEvent - host state = QuickMatchInternal::S_Searching
16:13:39.25    Host state; QuickMatchInternal::S_Searching 
16:13:44.00    QuickMatchInternal - Found a match, trying to join.
16:13:44.00    Set state; QuickMatchInternal::S_Joining 
16:13:44.00    JoinAsync: Starting AsyncJob...
16:13:44.00    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:13:44.00    Created Matchinfo
16:13:44.00    PostPollEvent - host state = QuickMatchInternal::S_Joining
16:13:44.00    Host state; QuickMatchInternal::S_Joining 
16:13:44.02    OnlineJoinAsync success
16:13:44.02    OnJoinAdvertisementSuccess - joined online match, server leave notification required
16:13:44.02    Creation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] -
16:13:44.02    Transport::Connection request to live://192.168.1.3,213.151.186.5?port=524?mac=AHoS4gaW?abOnline=Cv4zAQAnQruWyRwAAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:13:44.02    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:13:44.02    Session::Connect host address live://192.168.1.3,213.151.186.5?port=524?mac=AHoS4gaW?abOnline=Cv4zAQAnQruWyRwAAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:13:44.04    Largest sent is now 642
16:13:44.61    Session - highest peerID now : 3
16:13:44.62    Session::PollTransportEvents AddPeerMessage recv'd for existing pending peer, the local peer
16:13:44.62    Session::PollTransportEvents AddPeerMessage recv'd for existing pending peer, the host
16:13:44.62    ValidateCustomData: called with 645 bytes of custom data
16:13:44.62    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - host 0
16:13:44.62    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - we are not the host, bailing.
16:13:44.62    Client accepted Peer 2 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:13:44.62    AdvertisementInternal::Process - EVENT_NEWPEER
16:13:44.62    LiveOnPeerAddAsync added playerID 2533274841002471 as Local player in index 0
16:13:44.62    Registering steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:13:44.62    ValidateCustomData: called with 397 bytes of custom data
16:13:44.62    Validation callback for for user [00090000:02d30f22] - steam [01100001:02ca4d5e] - host 0
16:13:44.62    Validation callback for for user [00090000:02d30f22] - steam [01100001:02ca4d5e] - we are not the host, bailing.
16:13:44.62    Client accepted Peer 1 into the match at address live://192.168.1.3,213.151.186.5?port=524?mac=AHoS4gaW?abOnline=Cv4zAQAnQruWyRwAAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:13:44.62    AdvertisementInternal::Process - EVENT_NEWPEER
16:13:44.62    LiveOnPeerAddAsync added playerID 2533274837782306 as Remote player
16:13:44.62    Registering steamID [01100001:02ca4d5e] with userID [00090000:02d30f22]
16:13:44.64    Accepted matchInfo updated 21 from host
16:13:44.64    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:13:44.64    JoinAsync - got operation info 0:SessionOperationInfo::SUCCESS
16:13:44.64    JoinAsync - completed with JoinResult = 0:JoinEvent::R_Success
16:13:44.64    AutomatchInternal::OnJoinComplete - Completed Join with success=1
16:13:44.64    AutomatchInternal::OnJoinComplete - automatcher is no longer active - ignoring
16:13:44.64    OnJoinComplete - join complete.
16:13:44.64    Set state; QuickMatchInternal::S_Waiting 
16:13:44.64    JoinAsync: AsyncJob Complete...
16:13:44.64    PostPollEvent - host state = QuickMatchInternal::S_Waiting
16:13:44.64    Host state; QuickMatchInternal::S_Waiting 
16:13:44.65    PostPollEvent - host state = QuickMatchInternal::S_Waiting
16:13:44.65    Host state; QuickMatchInternal::S_Waiting 
16:13:44.66    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:13:44.66    PeerID 1 is CONNECTED and has 0 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 39 percent, avg packet size is 569
16:13:44.67    Accepted matchInfo updated 23 from host
16:13:44.93    Accepted matchInfo updated 24 from host
16:13:44.93    Accepted matchInfo updated 26 from host
16:13:44.98    PostStatsAsync::Initialization - Stats Upload Schema[Name:DOW2][Version:1][crc:1799561214][len:168] Record[len:68]
16:13:44.98    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_schema_id.php?name=DOW2&version=1&crc=1799561214
16:13:45.19    QuickMatchInternal::OnQMMT_StartGame_To_Everyone - Got a start game.
16:13:45.19    opteh is now muted
16:13:45.19    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:13:45.21    opteh is now muted
16:13:45.21    GetMaxFrameTimeFromProfile: players=2 expected FPS=33.363770, bars=5, max avg=0.025, sd=0.005, 5 samples =  0.02 0.03 0.03 0.02 0.02
16:13:45.21    Set state; QuickMatchInternal::S_Starting 
16:13:45.21    PostPollEvent - host state = QuickMatchInternal::S_Starting
16:13:45.21    Host state; QuickMatchInternal::S_Starting 
16:13:45.21    QuickMatchInternal - StopPolling with state=QuickMatchInternal::S_Starting
16:13:45.21    Set state; QuickMatchInternal::S_Idle 
16:13:45.22    PostPollEvent - host state = QuickMatchInternal::S_Idle
16:13:45.22    Host state; QuickMatchInternal::S_Idle 
16:13:45.27    Accepted matchInfo updated 29 from host
16:13:45.27    LiveAdvertisement::SetJoinable, match doesn't use presence, nothing to do
16:13:45.42    PostStatsAsync::WaitForGetSchema - schema is id 46
16:13:45.42    HttpRequestAsync::Initialization - sending 68 bytes to dow2stats.relic.com///reports/post_report.php?schemaID=46
16:13:45.43    Accepted matchInfo updated 32 from host
16:13:45.86    SMT_UpdateCountDown_To_Everyone
16:13:46.87    SMT_UpdateCountDown_To_Everyone
16:13:47.87    SMT_UpdateCountDown_To_Everyone
16:13:48.86    SMT_UpdateCountDown_To_Everyone
16:13:49.87    SMT_UpdateCountDown_To_Everyone
16:13:50.88    SMT_UpdateCountDown_To_Everyone
16:13:50.88    SMT_StartGame_To_Everyone - received
16:13:50.88    GameSetupForm - Starting game
16:13:50.88    PopulateGameInfo - random seed:[1244988838], guid:[{ecdde0bf-433c-4bc3-a86b-5e7990d90148}], sync level:[0]
16:13:50.88    Accepted matchInfo updated 35 from host
16:13:50.88    AutomatchInternal::OnStartComplete - detected successful game start
16:13:50.88    APP -- Game Start
16:13:50.88    GAME -- Ending FE
16:13:50.88    ScaleformFrontEnd - Unloading Front End
16:13:50.91    MessageInternal::DestroyChannel: Destroyed channel SMSG
16:13:50.99    MessageInternal::CreateChannel: Created channel SYNC
16:13:50.99    P2PNetworkSynchronization::RegisterPeer - info, registered remote station [1].
16:13:50.99    P2PNetworkSynchronization::RegisterPeer - info, registered local station [2].
16:13:50.99    opteh is now muted
16:13:50.99    MessageInternal::CreateChannel: Channel GOBJ already exists
16:13:50.99    GAME -- *** Beginning mission 1v1typhonlowlands (2 Humans, 0 Computers) ***
16:13:50.99    GameObj::StartGameObj - info, network session GUID set to [{ecdde0bf-433c-4bc3-a86b-5e7990d90148}].
16:13:51.18    GAME -- Recording game
16:13:51.23    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2207MB] Used [62MB].
16:13:51.26    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2239MB] Used [30MB].
16:13:51.27    GAME -- Precaching Action
16:13:51.94    GAME -- Loading Animators
16:13:52.22    XSessionArbitrationRegister fine
16:13:52.73    XSessionStart fine
16:14:01.01    ImpassMap Load CRC
16:14:01.01      :  1056964608
16:14:01.01      :  1059892375
16:14:01.01      :  1053609165
16:14:01.01      :  0
16:14:01.01      g: 425632575
16:14:01.01      f: 425632575
16:14:01.79    MessageInternal::CreateChannel: Created channel GMCC
16:14:02.04    MessageInternal::CreateChannel: Created channel MODM
16:14:04.09    GAME -- Loading completed (13 seconds)
16:14:04.09    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:14:04.17    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:14:04.17    SIM -- Setting SyncErrorChecking level to Low
16:14:04.18    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:06.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:08.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:10.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:12.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:14.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:16.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:18.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [1134074078].
16:14:18.91    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:47386402, opteh]" finished loading with checksum [1134074078].
16:14:18.92    PerformanceRecorder::StartRecording for game size 2
16:14:18.92    GAME -- Starting mission...
16:14:19.73    LagArbitrator - station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]]
16:14:26.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:14:36.02    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:14:45.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:14:45.00    PeerID 1 is CONNECTED and has 325 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 9 percent, avg packet size is 89
16:15:27.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:15:37.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:15:46.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:15:46.00    PeerID 1 is CONNECTED and has 935 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 9 percent, avg packet size is 80
16:16:28.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:16:38.00    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:16:47.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:16:47.00    PeerID 1 is CONNECTED and has 1545 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 11 percent, avg packet size is 72
16:17:29.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:17:39.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:17:48.02    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:17:48.02    PeerID 1 is CONNECTED and has 2155 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 6 percent, avg packet size is 83
16:18:30.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:18:40.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:18:49.01    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:18:49.01    PeerID 1 is CONNECTED and has 2765 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 17 percent, avg packet size is 123
16:19:31.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:19:41.00    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/2, max unsent 0, version mismatches 0 and blocked 0
16:19:50.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:19:50.00    PeerID 1 is CONNECTED and has 3375 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 5 percent, avg packet size is 88
16:20:32.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:20:42.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:20:51.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:20:51.00    PeerID 1 is CONNECTED and has 3985 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 5 percent, avg packet size is 88
16:21:33.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:21:43.00    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:21:52.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:21:52.00    PeerID 1 is CONNECTED and has 4596 message receipts and 2 messages pending receipt, highwater out of sequence is 0, avg compression is 5 percent, avg packet size is 87
16:22:34.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:22:44.02    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:22:53.01    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:22:53.01    PeerID 1 is CONNECTED and has 5205 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 8 percent, avg packet size is 97
16:23:35.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:23:45.01    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:23:54.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:23:54.00    PeerID 1 is CONNECTED and has 5816 message receipts and 2 messages pending receipt, highwater out of sequence is 0, avg compression is 13 percent, avg packet size is 106
16:24:36.02    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:24:46.02    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:24:55.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:24:55.00    PeerID 1 is CONNECTED and has 6425 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 4 percent, avg packet size is 88
16:25:37.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:25:47.01    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:25:56.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:25:56.00    PeerID 1 is CONNECTED and has 7035 message receipts and 4 messages pending receipt, highwater out of sequence is 0, avg compression is 5 percent, avg packet size is 87
16:26:38.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:26:48.00    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:26:57.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:26:57.00    PeerID 1 is CONNECTED and has 7646 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 5 percent, avg packet size is 87
16:27:39.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:27:49.00    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:27:58.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:27:58.00    PeerID 1 is CONNECTED and has 8256 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 6 percent, avg packet size is 80
16:28:40.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:28:50.02    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:28:59.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:28:59.00    PeerID 1 is CONNECTED and has 8866 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 8 percent, avg packet size is 82
16:29:41.01    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:29:51.01    Transport::Update median kBPS [highest/current] sent = 3/1, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:30:00.01    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:30:00.01    PeerID 1 is CONNECTED and has 9476 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 11 percent, avg packet size is 71
16:30:38.73    MOD -- Could not find win condition 'vpticker'
16:30:38.73    MOD -- Player opteh has been killed (frame 9791)
16:30:38.73    MOD -- Game Over at frame 9791
16:30:38.83    PartyProgresser PrintStatus size [2]
16:30:38.83    PartyProgresser Status user[[00090000:02d30f22]], status[0]
16:30:38.83    PartyProgresser Status user[[00090000:030431e7]], status[0]
16:30:38.83    ReportMatchStats - SimID:1000, raceID:2, teamID:0, uid:589824:47386402, result:3:PS_KILLED
16:30:38.83    CreateSessionStats for userID 2533274837782306 on teamID 0
16:30:38.83    LiveReportStats reporting 6 views for userID 2533274837782306
16:30:38.83    ReportMatchStats - SimID:1001, raceID:2, teamID:1, uid:589824:50606567, result:5:PS_WON
16:30:38.83    CreateSessionStats for userID 2533274841002471 on teamID 1
16:30:38.83    LiveReportStats reporting 6 views for userID 2533274841002471
16:30:38.83    ReportMatchStats - reporting normal game results for match [00000000:46bf08db]
16:30:38.83    ReportSimStats - storing simulation results for match 0:1186924763
16:30:38.83    PartyProgresser::HandleCountdownInfo value [10]
16:30:38.86    LiveReportStats completed fine
16:30:38.89    LiveReportStats completed fine
16:30:39.00    PartyProgresser::HandleCountdownInfo value [9]
16:30:39.57    LiveReportResults fine
16:30:40.00    PartyProgresser::HandleCountdownInfo value [8]
16:30:41.00    PartyProgresser::HandleCountdownInfo value [7]
16:30:42.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:30:42.00    PartyProgresser::HandleCountdownInfo value [6]
16:30:42.35    ReportStats - already reported or no need to report for match [00000000:46bf08db]
16:30:42.35    APP -- Game Stop
16:30:42.35    GameApp::TransitionGameStop
16:30:42.35    GameApp::TransitionQuitCommon
16:30:42.35    opteh is now unmuted
16:30:42.35    PerformanceRecorder: Updating profile history
16:30:42.35    GetMaxFrameTimeFromProfile: players=2 expected FPS=32.683849, bars=5, max avg=0.026, sd=0.004, 5 samples =  0.03 0.02 0.03 0.03 0.02
16:30:42.35    PerformanceRecorder::EndRecording - game size=2, max average=0.026793, worst frame=0.030596
16:30:42.35     Recording: No [2 players]

16:30:42.35     Total frame time: 2.96 sec

16:30:42.35     Total frame count: 201

16:30:42.35     Max/Avg: 0.03, 0.02 sec (fps=37.32, 47.89) (48 samples)

16:30:42.35     Bars: 5

16:30:42.35    Profile Max Performance[2 players] =  0.03 0.02 0.03 0.03 0.02
16:30:42.35    Profile Avg Performance[2 players] =  0.02 0.02 0.02 0.02 0.02
16:30:42.35    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2108MB] Used [161MB].
16:30:42.47    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:30:42.47    GameObj::ShutdownGameObj
16:30:42.47    GAME -- Beginning FE
16:30:42.47    GAME -- Ending mission - 'Game over'
16:30:42.66    MessageInternal::DestroyChannel: Destroyed channel MODM
16:30:42.96    SOUND -- Flushing cache ...
16:30:42.99    SOUND -- Flush complete!
16:30:42.99    CRCBlockManager Max Count: 13
16:30:42.99    MessageInternal::DestroyChannel: Destroyed channel GMCC
16:30:42.99    MessageInternal::DestroyChannel: Destroyed channel SYNC
16:30:43.10    ScaleformFrontEnd::Process - preloading task complete
16:30:43.10    starting fe
16:30:43.10    ScaleformFrontEnd - Loading Front End
16:30:47.05    starting fe done
16:30:47.05    ScaleformFrontEnd::Process - threaded loading task complete
16:30:47.14    FactoryT - CreateForm transition_movie
16:30:47.17    Unhandled callback "_level0.display_item.panel1_mc.panel_mc.OnTabSelected" from movie "DATA:ui\movies\front_end\front_end_fullscreen_display.gfx"
16:30:47.17    FactoryT - CreateForm mp_postgame
16:30:47.17    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:30:47.22    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:30:47.23    PartyProgresser::SendArriveAtPostgameMessage partyUp[2]
16:30:47.24    PostGameStatsForm::InvokeSetPlayerStatus
16:30:47.24    PostGameStatsForm::InvokeSetPlayerStatus - 2 args
16:30:47.24    PostGameStatsForm::InvokeSetPartyIcon
16:30:47.24    FactoryT - CreateForm chat_panel
16:30:47.24    FactoryT - CreateForm rank_message_box
16:30:50.46    FactoryT - CreateForm player_stats_frame
16:30:50.47    FactoryT - CreateForm gamehistory_stats
16:30:50.71    PartyProgresser - PPMT_ArriveAtPostgame_To_Everyone - received
16:30:50.71    PartyProgresser PrintStatus size [2]
16:30:50.71    PartyProgresser Status user[[00090000:02d30f22]], status[1]
16:30:50.71    PartyProgresser Status user[[00090000:030431e7]], status[1]
16:30:50.71    PostGameStatsForm::OnArriveAtPostgame - userID[2533274837782306]
16:30:50.71    PostGameStatsForm::InvokeSetPlayerStatus
16:30:50.71    PostGameStatsForm::InvokeSetPlayerStatus - 2 args
16:30:50.71    PostGameStatsForm::InvokeSetPartyIcon
16:30:52.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:31:01.00    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:31:01.00    PeerID 1 is CONNECTED and has 9868 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 10 percent, avg packet size is 71
16:31:04.45    FactoryT - CreateForm player_stats_frame
16:31:04.45    FactoryT - CreateForm gamehistory_stats
16:31:12.46    Closed connection by remote request for PeerID 1 at live://192.168.1.3,213.151.186.5?port=524?mac=AHoS4gaW?abOnline=Cv4zAQAnQruWyRwAAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:31:12.48    Session::ProcessPeerMessages received RemovePeerMessage for Peer 1
16:31:12.48    Session::ProcessPeerMessages LocalPeer is marking PeerID 1 for death on instruction from Host
16:31:12.48    AdvertisementInternal::Process - EVENT_HOSTMIGRATION
16:31:12.48    MatchInternal::OnHostMigration - Hosting has migrated to us, updating match info
16:31:12.48    Net::Session::SetVisible - session is set to INVISIBLE.
16:31:12.48    Closed connection for PeerID 1 at live://192.168.1.3,213.151.186.5?port=524?mac=AHoS4gaW?abOnline=Cv4zAQAnQruWyRwAAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:31:12.48    AdvertisementInternal::Process - EVENT_DESTROYPEER
16:31:12.48    Removing steamID [01100001:02ca4d5e] with userID [00090000:02d30f22]
16:31:12.48    PostGameStatsForm::OnArriveAtPostgame - userID[2533274837782306]
16:31:12.48    PostGameStatsForm::InvokeSetPlayerStatus
16:31:12.48    PostGameStatsForm::InvokeSetPlayerStatus - 2 args
16:31:12.48    PostGameStatsForm::InvokeSetPartyIcon
16:31:12.49    LiveOnPeerRemoveAsync removed playerID 2533274837782306 as Remote player
16:31:12.96    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQ7caSpsDA=?XnKey=1OLH4ltDXPHH+ZHu3PidjA==
16:31:12.96    Closed connection for PeerID 2 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQz6Q1JQPU=?XnKey=UZ18BS6CxMKf2jc8SA83iw==
16:31:12.96    LiveOnHostMigrationAsync HOST completed
16:31:12.97    Transport::Close - Requested Disconnect for connectionID 14 with no connection
16:31:12.97    Transport::Close - Requested Disconnect for connectionID 14 with no event handlers.
16:31:30.34    Calling disconnect...
16:31:30.34    Session is marking the local peer PeerID 1 for death
16:31:30.34    Session is marking the local peer PeerID 2 for death
16:31:30.34    Closed connection for PeerID 2 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAQ7caSpsDA=?XnKey=1OLH4ltDXPHH+ZHu3PidjA==
16:31:30.34    AdvertisementInternal::Process - EVENT_DESTROYPEER
16:31:30.34    Removing steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:31:30.34    LeaveMatchInternal - no action taken, needLeave=0, service=0
16:31:30.34    Destroyed Matchinfo
16:31:30.34    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAGEYry3ro0=?XnKey=FSTxsKXIbsXV5Epi3HCM1Q==
16:31:30.34    PartyInternal::Process - EVENT_DESTROYPEER
16:31:30.34    LeavePartyInternal - no action taken, needLeave=0
16:31:30.34    Destroyed Partyinfo
16:31:30.34    LiveOnPeerRemoveAsync removed playerID 2533274841002471 as Local player in index 0
16:31:30.80    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:31:30.80    RemoveAllPeers - flushing local session peer data
16:31:30.80    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
16:31:31.27    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:31:31.27    PeerRemoveAll - flushing local session peer data
16:31:31.27    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
16:31:31.27    Created Partyinfo
16:31:31.27    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:31:31.75    OnServiceJoinSuccess - joined online party, server leave notification required
16:31:31.75    starting local hosting
16:31:31.75    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAEkXhWgXoY=?XnKey=ab7qH5bk/+cbVRsRzhneQA==
16:31:31.75    ValidateCustomData: called with 101 bytes of custom data
16:31:31.75    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAEkXhWgXoY=?XnKey=ab7qH5bk/+cbVRsRzhneQA==
16:31:31.75    PartyInternal::Process - EVENT_NEWPEER
16:31:31.75    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:31:31.77    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:31:31.77    hosting - Session is connected
16:31:31.77    hosting completed successfully
16:31:31.77    HostAsync - completed with HostResult = 0
16:31:31.79    FactoryT - CreateForm matchmaking
16:31:31.79    MessageInternal::CreateChannel: Created channel SMSG
16:31:31.79    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:31:31.79    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:31:31.79    FactoryT - CreateForm chat_panel
16:31:31.79    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
16:31:31.80    FactoryT - CreateForm party_panel
16:31:31.80    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:31:31.80    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
16:31:31.81    FactoryT - CreateForm hero_selection_panel
16:31:31.86    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
16:31:31.88    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:31:31.88    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:31:31.93    FactoryT - CreateForm game_options_panel
16:31:31.93    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
16:31:32.25    destLen = 269
16:31:33.24    MessageInternal::DestroyChannel: Destroyed channel SMSG
16:31:33.25    FactoryT - CreateForm main_menu
16:31:33.25    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2172MB] Used [97MB].
16:31:33.30    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2231MB] Used [38MB].
16:31:33.32    FactoryT - CreateForm news
16:31:33.39    Session is marking the local peer PeerID 1 for death
16:31:33.44    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAEkXhWgXoY=?XnKey=ab7qH5bk/+cbVRsRzhneQA==
16:31:33.44    PartyInternal::Process - EVENT_DESTROYPEER
16:31:33.44    LeavePartyInternal - no action taken, needLeave=0
16:31:33.44    Destroyed Partyinfo
16:31:34.54    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:31:34.54    RemoveAllPeers - flushing local session peer data
16:31:34.54    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
16:31:53.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:32:45.33    VIDEO -- Texture Memory Start Device Reset: Video  [512MB] Total [2269MB] Available [2269MB] Used [0MB].
16:32:45.40    VIDEO -- Texture Memory End Device Reset: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:32:54.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:33:26.68    FactoryT - CreateForm game_list_movie
16:33:30.41    GameListForm::CancelConnection m_connectingMBID == INVALID_SF_MESSAGE_BOX_ID nothing to do
16:33:30.42    FactoryT - CreateForm main_menu
16:33:30.42    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2187MB] Used [82MB].
16:33:30.43    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2239MB] Used [30MB].
16:33:30.45    FactoryT - CreateForm news
16:33:31.81    Created Partyinfo
16:33:31.81    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:33:32.30    OnServiceJoinSuccess - joined online party, server leave notification required
16:33:32.30    starting local hosting
16:33:32.30    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAEe0XTW2Js=?XnKey=1Mqiqk3rcnX/DX1diPWfYg==
16:33:32.30    ValidateCustomData: called with 101 bytes of custom data
16:33:32.30    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAEe0XTW2Js=?XnKey=1Mqiqk3rcnX/DX1diPWfYg==
16:33:32.30    PartyInternal::Process - EVENT_NEWPEER
16:33:32.30    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:33:32.32    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:33:32.32    hosting - Session is connected
16:33:32.33    hosting completed successfully
16:33:32.33    HostAsync - completed with HostResult = 0
16:33:32.33    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:33:32.35    FactoryT - CreateForm matchmaking
16:33:32.35    MessageInternal::CreateChannel: Created channel SMSG
16:33:32.35    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:33:32.35    FactoryT - CreateForm chat_panel
16:33:32.35    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
16:33:32.36    FactoryT - CreateForm party_panel
16:33:32.36    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:33:32.36    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
16:33:32.36    FactoryT - CreateForm hero_selection_panel
16:33:32.41    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
16:33:32.44    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:33:32.44    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:33:32.48    FactoryT - CreateForm game_options_panel
16:33:32.48    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
16:33:32.66    destLen = 269
16:33:33.58    MessageInternal::DestroyChannel: Destroyed channel SMSG
16:33:33.59    FactoryT - CreateForm main_menu
16:33:33.59    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2173MB] Used [96MB].
16:33:33.64    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2231MB] Used [38MB].
16:33:33.65    FactoryT - CreateForm news
16:33:33.65    Session is marking the local peer PeerID 1 for death
16:33:33.66    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAEe0XTW2Js=?XnKey=1Mqiqk3rcnX/DX1diPWfYg==
16:33:33.66    PartyInternal::Process - EVENT_DESTROYPEER
16:33:33.66    LeavePartyInternal - no action taken, needLeave=0
16:33:33.66    Destroyed Partyinfo
16:33:34.34    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:33:34.34    RemoveAllPeers - flushing local session peer data
16:33:34.34    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
16:33:35.43    Created Matchinfo
16:33:35.43    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:33:35.43    Creation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] -
16:33:35.43    starting online hosting
16:33:35.93    OnJoinAdvertisementSuccess - joined online match, server leave notification required
16:33:35.93    starting local hosting
16:33:35.93    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAGbtDHUekU=?XnKey=KRTw0l4h6x9n0jyJHp/BZA==
16:33:35.93    ValidateCustomData: called with 385 bytes of custom data
16:33:35.93    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - host 1
16:33:35.93    Steam ID is not registered [01100001:01b0619f]
16:33:35.93    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAGbtDHUekU=?XnKey=KRTw0l4h6x9n0jyJHp/BZA==
16:33:35.93    AdvertisementInternal::Process - EVENT_NEWPEER
16:33:35.93    LiveOnPeerAddAsync added playerID 2533274841002471 as Local player in index 0
16:33:35.93    Registering steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:33:35.93    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:33:35.95    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:33:35.95    hosting - Session is connected
16:33:35.95    Net::Session::SetHostGameStarted - session is set to SETUP.
16:33:35.95    Net::Session::SetVisible - session is set to VISIBLE.
16:33:35.95    hosting completed successfully
16:33:35.95    HostAsync - completed with HostResult = 0
16:33:35.96    AutomatchInternal::OnHostComplete - Completed Host with success=1
16:33:35.96    AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
16:33:35.96    QuickMatchInternal::OnHostComplete - Host complete.
16:33:35.96    QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
16:33:35.96    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:33:35.98    FactoryT - CreateForm game_setup_movie
16:33:35.98    MessageInternal::CreateChannel: Created channel SMSG
16:33:35.98    FactoryT - CreateForm hero_selection_panel
16:33:36.07    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:33:36.07    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:33:36.09    FactoryT - CreateForm player_list_panel
16:33:36.10    FactoryT - CreateForm chat_panel
16:33:36.13    FactoryT - CreateForm game_options_panel
16:33:36.14    GetMaxFrameTimeFromProfile: players=2 expected FPS=32.683849, bars=5, max avg=0.026, sd=0.004, 5 samples =  0.03 0.02 0.03 0.03 0.02
16:33:36.29    destLen = 371
16:33:38.14    Hero sbps\pvp\race_marine\heroes\sm_apothecary has been selected
16:33:38.14    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:33:38.66    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:33:38.66    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:33:39.84    Hero sbps\pvp\race_marine\heroes\sm_apothecary has been selected
16:33:39.84    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:33:40.32    Hero sbps\pvp\race_marine\heroes\sm_apothecary has been selected
16:33:41.07    destLen = 370
16:33:42.25    Net::Session::SetHostGameStarted - session is set to INGAME.
16:33:42.25    MatchInternal::SetMatchState - state 1 - updating server
16:33:42.25    Net::Session::SetVisible - session is set to INVISIBLE.
16:33:42.25    MatchSetup: Sending start game message!
16:33:42.25    GameSetupForm - Starting game
16:33:42.25    PopulateGameInfo - random seed:[1244990022], guid:[{64b062b7-6b64-45db-a19b-6c28399f35cd}], sync level:[0]
16:33:42.25    Session is marking the local peer PeerID 1 for death
16:33:42.25    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAGbtDHUekU=?XnKey=KRTw0l4h6x9n0jyJHp/BZA==
16:33:42.25    AdvertisementInternal::Process - EVENT_DESTROYPEER
16:33:42.25    Removing steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:33:42.25    LeaveMatchInternal - no action taken, needLeave=0, service=0
16:33:42.25    Destroyed Matchinfo
16:33:42.26    APP -- Game Start
16:33:42.26    GAME -- Ending FE
16:33:42.26    ScaleformFrontEnd - Unloading Front End
16:33:42.28    MessageInternal::DestroyChannel: Destroyed channel SMSG
16:33:42.40    GAME -- *** Beginning mission 2p_calderisdunes (1 Humans, 1 Computers) ***
16:33:42.58    GAME -- Recording game
16:33:42.63    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2189MB] Used [80MB].
16:33:42.67    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2231MB] Used [38MB].
16:33:42.67    GAME -- Precaching Action
16:33:42.77    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:33:42.77    LiveOnPeerRemoveAsync removed playerID 2533274841002471 as Local player in index 0
16:33:43.32    PeerRemoveAll - flushing local session peer data
16:33:43.32    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
16:33:43.50    GAME -- Loading Animators
16:33:55.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:33:57.93    ImpassMap Load CRC
16:33:57.93      :  1056964608
16:33:57.93      :  1059892375
16:33:57.93      :  1053609165
16:33:57.93      :  0
16:33:57.93      g: 425632575
16:33:57.93      f: 425632575
16:33:59.00    MessageInternal::CreateChannel: Created channel GMCC
16:33:59.24    MessageInternal::CreateChannel: Created channel MODM
16:34:01.71    GAME -- Loading completed (19 seconds)
16:34:01.71    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:34:01.79    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:34:01.79    SIM -- Setting SyncErrorChecking level to None
16:34:09.19    PerformanceRecorder::StartRecording for game size 2
16:34:09.19    GAME -- Starting mission...
16:34:20.74    WorldViewSM::ProcessWVEvents - setting pause to 1
16:34:20.76    GAME -- SimulationController::Pause 0
16:34:22.66    ReportMatchStats - not a network game, nothing to do
16:34:22.66    ReportSimStats - storing simulation results for match 0:2537914684
16:34:22.66    GameApp::ReportSimStats - warning, [ability\pvp\race_marine\sm_hero_xp_modifier] does not have localized name.
16:34:22.66    GameApp::ReportSimStats - warning, [ability\pvp\race_marine\sm_hq_impassable_landing_pad] does not have localized name.
16:34:22.66    GameApp::ReportSimStats - warning, [ability\pvp\race_marine\sm_hero_xp_modifier] does not have localized name.
16:34:22.66    PostStatsAsync::Initialization - Stats Upload Schema[Name:DOW2][Version:1][crc:2198648058][len:4673] Record[len:1754]
16:34:22.66    APP -- Game Stop
16:34:22.66    GameApp::TransitionGameStop
16:34:22.66    GameApp::TransitionQuitCommon
16:34:22.66    Unable to mute opposing team, could not get the MatchInfo
16:34:22.66    PerformanceRecorder: Not enough game time to update profile history
16:34:22.66    GetMaxFrameTimeFromProfile: players=2 expected FPS=32.683849, bars=5, max avg=0.026, sd=0.004, 5 samples =  0.03 0.02 0.03 0.03 0.02
16:34:22.66    PerformanceRecorder::EndRecording - game size=2, max average=0.000000, worst frame=0.030596
16:34:22.66     Recording: No [2 players]

16:34:22.66     Total frame time: 13.47 sec

16:34:22.66     Total frame count: 682

16:34:22.66     Max/Avg: 0.00, 0.00 sec (fps=0.00, 0.00) (-1 samples)

16:34:22.66     Bars: 0

16:34:22.66    Profile Max Performance[2 players] =  0.03 0.02 0.03 0.03 0.02
16:34:22.66    Profile Avg Performance[2 players] =  0.02 0.02 0.02 0.02 0.02
16:34:22.66    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2144MB] Used [125MB].
16:34:22.72    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2226MB] Used [43MB].
16:34:22.72    GameObj::ShutdownGameObj
16:34:22.72    GAME -- Beginning FE
16:34:22.72    GAME -- Ending mission - 'Abort'
16:34:22.72    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_schema_id.php?name=DOW2&version=1&crc=2198648058
16:34:22.97    MessageInternal::DestroyChannel: Destroyed channel MODM
16:34:23.20    PostStatsAsync::WaitForGetSchema - schema is id 45
16:34:23.20    HttpRequestAsync::Initialization - sending 1754 bytes to dow2stats.relic.com///reports/post_report.php?schemaID=45
16:34:23.25    SOUND -- Flushing cache ...
16:34:23.29    SOUND -- Flush complete!
16:34:23.29    CRCBlockManager Max Count: 13
16:34:23.29    MessageInternal::DestroyChannel: Destroyed channel GMCC
16:34:23.41    ScaleformFrontEnd::Process - preloading task complete
16:34:23.41    starting fe
16:34:23.41    ScaleformFrontEnd - Loading Front End
16:34:27.58    starting fe done
16:34:27.58    ScaleformFrontEnd::Process - threaded loading task complete
16:34:27.68    FactoryT - CreateForm transition_movie
16:34:27.71    Unhandled callback "_level0.display_item.panel1_mc.panel_mc.OnTabSelected" from movie "DATA:ui\movies\front_end\front_end_fullscreen_display.gfx"
16:34:27.71    FactoryT - CreateForm mp_postgame
16:34:27.71    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:34:27.76    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:34:27.76    Session::SendData local peer is missing, not sending
16:34:27.76    PartyProgresser::SendArriveAtPostgameMessage partyUp[2]
16:34:27.77    PostGameStatsForm::InvokeSetPlayerStatus
16:34:27.77    PostGameStatsForm::InvokeSetPlayerStatus - 2 args
16:34:27.77    PostGameStatsForm::InvokeSetPartyIcon
16:34:27.77    FactoryT - CreateForm chat_panel
16:34:27.77    FactoryT - CreateForm rank_message_box
16:34:31.04    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:34:31.05    FactoryT - CreateForm main_menu
16:34:31.05    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2240MB] Used [29MB].
16:34:31.06    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2240MB] Used [29MB].
16:34:31.10    FactoryT - CreateForm news
16:34:56.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:35:57.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:36:58.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:37:59.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:39:00.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:40:01.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:40:07.06    VIDEO -- Texture Memory Start Device Reset: Video  [512MB] Total [2269MB] Available [2269MB] Used [0MB].
16:40:07.18    VIDEO -- Texture Memory End Device Reset: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:40:10.31    Got XN_SYS_UI - guide enabled
16:40:25.51    Got XN_SYS_UI - guide disabled
16:40:27.43    FactoryT - CreateForm gamehistory_tabs
16:40:27.44    FactoryT - CreateForm gamehistory_replays
16:40:27.63    GAME -- Error reading header for recorded game PLAYBACK:eas vs gaddy 1.rec
16:40:27.72    GAME -- Error reading header for recorded game PLAYBACK:eas vs gaddy 2.rec
16:40:28.26    FactoryT - CreateForm gamehistory_stats
16:40:44.11    FactoryT - CreateForm main_menu
16:40:44.11    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2179MB] Used [90MB].
16:40:44.15    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2236MB] Used [33MB].
16:40:44.18    FactoryT - CreateForm news
16:40:46.60    Got XN_SYS_UI - guide enabled
16:41:02.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:41:04.47    Got XN_SYS_UI - guide disabled
16:41:05.29    Created Partyinfo
16:41:05.29    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:41:05.79    OnServiceJoinSuccess - joined online party, server leave notification required
16:41:05.79    starting local hosting
16:41:05.79    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAH2RJTSj7Q=?XnKey=ZX/GfJ7PPS9h18y2JhGriA==
16:41:05.79    ValidateCustomData: called with 101 bytes of custom data
16:41:05.79    Host accepted Peer 1 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAH2RJTSj7Q=?XnKey=ZX/GfJ7PPS9h18y2JhGriA==
16:41:05.79    PartyInternal::Process - EVENT_NEWPEER
16:41:05.79    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
16:41:05.80    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:41:05.80    hosting - Session is connected
16:41:05.81    hosting completed successfully
16:41:05.81    HostAsync - completed with HostResult = 0
16:41:05.82    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:41:05.83    FactoryT - CreateForm matchmaking
16:41:05.83    MessageInternal::CreateChannel: Created channel SMSG
16:41:05.83    FactoryT - CreateForm chat_panel
16:41:05.83    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
16:41:05.84    FactoryT - CreateForm party_panel
16:41:05.84    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:41:05.84    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
16:41:05.85    FactoryT - CreateForm hero_selection_panel
16:41:05.89    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
16:41:05.92    Hero sbps\pvp\race_marine\heroes\sm_apothecary has been selected
16:41:05.92    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:41:05.97    FactoryT - CreateForm game_options_panel
16:41:05.97    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
16:41:06.22    destLen = 243
16:41:07.67    Hero sbps\pvp\race_ork\heroes\ork_warboss has been selected
16:41:07.67    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:41:08.79    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:41:09.51    QuickMatchInternal - StartPolling
16:41:09.51    Set state; QuickMatchInternal::S_Searching 
16:41:09.51    PostPollEvent - host state = QuickMatchInternal::S_Searching
16:41:09.51    Host state; QuickMatchInternal::S_Searching 
16:41:14.00    QuickMatchInternal - Found a match, trying to join.
16:41:14.00    Set state; QuickMatchInternal::S_Joining 
16:41:14.00    JoinAsync: Starting AsyncJob...
16:41:14.00    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
16:41:14.00    Created Matchinfo
16:41:14.00    PostPollEvent - host state = QuickMatchInternal::S_Joining
16:41:14.00    Host state; QuickMatchInternal::S_Joining 
16:41:14.03    OnlineJoinAsync success
16:41:14.03    OnJoinAdvertisementSuccess - joined online match, server leave notification required
16:41:14.04    Creation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] -
16:41:14.04    Transport::Connection request to live://10.0.0.3,88.108.35.10?port=60251?mac=AKdY7jcL?abOnline=Cv4DAQCFqavQ/hsAAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:41:14.04    Transport::Connection request to live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:41:14.04    Session::Connect host address live://10.0.0.3,88.108.35.10?port=60251?mac=AKdY7jcL?abOnline=Cv4DAQCFqavQ/hsAAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:41:14.06    Largest sent is now 648
16:41:14.51    Session - highest peerID now : 3
16:41:14.51    Session::PollTransportEvents AddPeerMessage recv'd for existing pending peer, the local peer
16:41:14.51    Session::PollTransportEvents AddPeerMessage recv'd for existing pending peer, the host
16:41:14.51    ValidateCustomData: called with 645 bytes of custom data
16:41:14.51    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - host 0
16:41:14.51    Validation callback for for user [00090000:030431e7] - steam [01100001:01b0619f] - we are not the host, bailing.
16:41:14.51    Client accepted Peer 2 into the match at address live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:41:14.51    AdvertisementInternal::Process - EVENT_NEWPEER
16:41:14.51    LiveOnPeerAddAsync added playerID 2533274841002471 as Local player in index 0
16:41:14.51    Registering steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:41:14.51    ValidateCustomData: called with 423 bytes of custom data
16:41:14.51    Validation callback for for user [00090000:02c19361] - steam [01100001:01e7b059] - host 0
16:41:14.51    Validation callback for for user [00090000:02c19361] - steam [01100001:01e7b059] - we are not the host, bailing.
16:41:14.51    Client accepted Peer 1 into the match at address live://10.0.0.3,88.108.35.10?port=60251?mac=AKdY7jcL?abOnline=Cv4DAQCFqavQ/hsAAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:41:14.51    AdvertisementInternal::Process - EVENT_NEWPEER
16:41:14.51    LiveOnPeerAddAsync added playerID 2533274836636513 as Remote player
16:41:14.51    Registering steamID [01100001:01e7b059] with userID [00090000:02c19361]
16:41:14.53    Accepted matchInfo updated 21 from host
16:41:14.53    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
16:41:14.53    Accepted matchInfo updated 23 from host
16:41:14.53    JoinAsync - got operation info 0:SessionOperationInfo::SUCCESS
16:41:14.54    JoinAsync - completed with JoinResult = 0:JoinEvent::R_Success
16:41:14.54    AutomatchInternal::OnJoinComplete - Completed Join with success=1
16:41:14.54    AutomatchInternal::OnJoinComplete - automatcher is no longer active - ignoring
16:41:14.54    OnJoinComplete - join complete.
16:41:14.54    Set state; QuickMatchInternal::S_Waiting 
16:41:14.54    JoinAsync: AsyncJob Complete...
16:41:14.54    PostPollEvent - host state = QuickMatchInternal::S_Waiting
16:41:14.54    Host state; QuickMatchInternal::S_Waiting 
16:41:14.54    PostPollEvent - host state = QuickMatchInternal::S_Waiting
16:41:14.54    Host state; QuickMatchInternal::S_Waiting 
16:41:14.56    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:41:14.56    PeerID 1 is CONNECTED and has 0 message receipts and 5 messages pending receipt, highwater out of sequence is 0, avg compression is 38 percent, avg packet size is 575
16:41:14.77    QuickMatchInternal::OnQMMT_StartGame_To_Everyone - Got a start game.
16:41:14.77    Lodgeinator is now muted
16:41:14.77    RankManager::GetLocalPlayerExp can't ask again yet, bailing
16:41:14.78    Lodgeinator is now muted
16:41:14.78    GetMaxFrameTimeFromProfile: players=2 expected FPS=32.683849, bars=5, max avg=0.026, sd=0.004, 5 samples =  0.03 0.02 0.03 0.03 0.02
16:41:14.78    Set state; QuickMatchInternal::S_Starting 
16:41:14.78    PostPollEvent - host state = QuickMatchInternal::S_Starting
16:41:14.78    Host state; QuickMatchInternal::S_Starting 
16:41:14.78    QuickMatchInternal - StopPolling with state=QuickMatchInternal::S_Starting
16:41:14.79    Set state; QuickMatchInternal::S_Idle 
16:41:14.80    PostPollEvent - host state = QuickMatchInternal::S_Idle
16:41:14.80    Host state; QuickMatchInternal::S_Idle 
16:41:14.87    Accepted matchInfo updated 27 from host
16:41:14.87    LiveAdvertisement::SetJoinable, match doesn't use presence, nothing to do
16:41:14.88    PostStatsAsync::Initialization - Stats Upload Schema[Name:DOW2][Version:1][crc:1799561214][len:168] Record[len:68]
16:41:14.88    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_schema_id.php?name=DOW2&version=1&crc=1799561214
16:41:15.03    Accepted matchInfo updated 30 from host
16:41:15.06    SMT_UpdateCountDown_To_Everyone
16:41:15.36    PostStatsAsync::WaitForGetSchema - schema is id 46
16:41:15.37    HttpRequestAsync::Initialization - sending 68 bytes to dow2stats.relic.com///reports/post_report.php?schemaID=46
16:41:16.04    SMT_UpdateCountDown_To_Everyone
16:41:17.02    SMT_UpdateCountDown_To_Everyone
16:41:18.04    SMT_UpdateCountDown_To_Everyone
16:41:19.06    SMT_UpdateCountDown_To_Everyone
16:41:20.04    SMT_UpdateCountDown_To_Everyone
16:41:20.04    SMT_StartGame_To_Everyone - received
16:41:20.04    GameSetupForm - Starting game
16:41:20.04    PopulateGameInfo - random seed:[1244990486], guid:[{a13435d2-4b83-4774-9073-7df3ee9db300}], sync level:[0]
16:41:20.04    Accepted matchInfo updated 33 from host
16:41:20.04    AutomatchInternal::OnStartComplete - detected successful game start
16:41:20.04    APP -- Game Start
16:41:20.04    GAME -- Ending FE
16:41:20.04    ScaleformFrontEnd - Unloading Front End
16:41:20.07    MessageInternal::DestroyChannel: Destroyed channel SMSG
16:41:20.18    MessageInternal::CreateChannel: Created channel SYNC
16:41:20.18    P2PNetworkSynchronization::RegisterPeer - info, registered remote station [1].
16:41:20.18    P2PNetworkSynchronization::RegisterPeer - info, registered local station [2].
16:41:20.18    Lodgeinator is now muted
16:41:20.18    MessageInternal::CreateChannel: Channel GOBJ already exists
16:41:20.18    GAME -- *** Beginning mission 2p_typhonswamp (2 Humans, 0 Computers) ***
16:41:20.18    GameObj::StartGameObj - info, network session GUID set to [{a13435d2-4b83-4774-9073-7df3ee9db300}].
16:41:20.37    GAME -- Recording game
16:41:20.43    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2186MB] Used [83MB].
16:41:20.46    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2230MB] Used [39MB].
16:41:20.48    GAME -- Precaching Action
16:41:21.03    GAME -- Loading Animators
16:41:21.31    XSessionArbitrationRegister fine
16:41:21.92    XSessionStart fine
16:41:33.79    ImpassMap Load CRC
16:41:33.79      :  1056964608
16:41:33.79      :  1059892375
16:41:33.79      :  1053609165
16:41:33.79      :  0
16:41:33.79      g: 425632575
16:41:33.79      f: 425632575
16:41:34.67    MessageInternal::CreateChannel: Created channel GMCC
16:41:34.99    MessageInternal::CreateChannel: Created channel MODM
16:41:36.96    GAME -- Loading completed (17 seconds)
16:41:36.96    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:41:37.04    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:41:37.04    SIM -- Setting SyncErrorChecking level to Low
16:41:37.05    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:39.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:41.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:43.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:45.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:47.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:49.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:51.00    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:50606567, Orkampel]" finished loading with checksum [181063929].
16:41:51.35    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:46240609, Lodgeinator]" finished loading with checksum [181063929].
16:41:51.36    PerformanceRecorder::StartRecording for game size 2
16:41:51.36    GAME -- Starting mission...
16:41:52.15    LagArbitrator - station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]]
16:41:58.72    WorldViewSM::ProcessWVEvents - setting pause to 1
16:42:03.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
16:42:06.00    PeerID 1 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:42:15.01    PeerID 2 is CONNECTED and has 0 message receipts and 0 messages pending receipt, highwater out of sequence is 0, avg compression is 0 percent, avg packet size is 0
16:42:15.01    PeerID 1 is CONNECTED and has 314 message receipts and 3 messages pending receipt, highwater out of sequence is 0, avg compression is 9 percent, avg packet size is 74
16:42:31.57    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [1], current lag complaint threshold = [2] frames.
16:42:31.71    LagArbitrator - station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]], is lagging for station [[sid 00000000:00000002, pid 589824:50606567, Orkampel]]
16:42:37.42    LiveTransport::Update unable to determined XNADDR for local peer
16:42:37.46    LiveTransport::Update unable to determined XNADDR for local peer
16:42:37.55    LiveTransport::Update unable to determined XNADDR for local peer
16:42:37.79    LiveAccountService:OnSignInChanged, clearing profile settings.
16:42:37.82    Session - XSocketSendTo failed, unreachable, closing connections
16:42:37.82    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [1], current lag complaint threshold = [2] frames.
16:42:37.82    Closed connection by remote request for PeerID 1 at live://10.0.0.3,88.108.35.10?port=60251?mac=AKdY7jcL?abOnline=Cv4DAQCFqavQ/hsAAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:42:37.82    Session is marking the local peer PeerID 1 for death
16:42:37.82    Session is marking PeerID 1 for death
16:42:37.82    Session is marking the local peer PeerID 2 for death
16:42:37.82    Closed connection for PeerID 1 at live://10.0.0.3,88.108.35.10?port=60251?mac=AKdY7jcL?abOnline=Cv4DAQCFqavQ/hsAAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:42:37.82    AdvertisementInternal::Process - EVENT_DESTROYPEER
16:42:37.82    Removing steamID [01100001:01e7b059] with userID [00090000:02c19361]
16:42:37.82    GameObjController - OnMatchEvent: event type 1
16:42:37.82    GameObj::OnRemoteStationDisconnected - info, remote station [1] was disconnected, disconnect reason code given [2], AI simulated players will migrate to [2].
16:42:37.82    GameObj::OnRemoteStationDisconnected - info, remote station [1] is disconnected, disconnection reason code [2].
16:42:37.82    P2PNetworkSynchronization::OnDestroyedPeerEvent - info, drop event received for remote station [1].
16:42:37.82    OnDestroyedPeerEvent - calling RemovePeerFromSync.
16:42:37.82    P2PNetworkSynchronization::StartConsolidation - info, starting consolidation for station, station id= [1].
16:42:37.82    P2PNetworkSynchronization::Vote - info, voting for consolidation, station id = [1], frame = [454]
16:42:37.82    Session::SendData local peer is marked for death, not sending
16:42:37.82    P2PNetworkSynchronization::CheckConsolidation - info, consolidation for station [1] completed.
16:42:37.82    Closed connection for PeerID 2 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAS7OekZmB4=?XnKey=M6rfCyu0PG84gyJXaYd7Lg==
16:42:37.82    AdvertisementInternal::Process - EVENT_DESTROYPEER
16:42:37.82    Removing steamID [01100001:01b0619f] with userID [00090000:030431e7]
16:42:37.82    GameObjController - OnMatchEvent: event type 1
16:42:37.82    P2PNetworkSynchronization::OnDestroyedPeerEvent - info, drop event received for local station [2].
16:42:37.82    LeaveMatchInternal - no action taken, needLeave=0, service=0
16:42:37.82    Destroyed Matchinfo
16:42:37.82    Closed connection for PeerID 1 at live://192.168.1.3,92.224.7.243?port=7989?mac=AFsXqHRG?abOnline=Cv4pAQA1Lw8ZJh0AAAAA+wIAAAA=?XnKid=gAH2RJTSj7Q=?XnKey=ZX/GfJ7PPS9h18y2JhGriA==
16:42:37.82    PartyInternal::Process - EVENT_DESTROYPEER
16:42:37.82    LeavePartyInternal - no action taken, needLeave=0
16:42:37.82    Destroyed Partyinfo
16:42:37.87    OnConnect: connect failure
16:42:37.87    OnConnect: this wasnt a reconnect, no need for autologin
16:42:37.88    Session - XSocketSendTo failed, unreachable, closing connections
16:42:37.88    APP -- Game Stop
16:42:37.88    GameApp::TransitionGameStop
16:42:37.88    GameApp::TransitionQuitCommon
16:42:37.88    Unable to mute opposing team, could not get the MatchInfo
16:42:37.88    PerformanceRecorder: Updating profile history
16:42:37.88    GetMaxFrameTimeFromProfile: players=2 expected FPS=32.657139, bars=5, max avg=0.026, sd=0.005, 5 samples =  0.02 0.03 0.02 0.03 0.03
16:42:37.88    PerformanceRecorder::EndRecording - game size=2, max average=0.020064, worst frame=0.030621
16:42:37.88     Recording: No [2 players]

16:42:37.88     Total frame time: 6.50 sec

16:42:37.88     Total frame count: 313

16:42:37.88     Max/Avg: 0.02, 0.02 sec (fps=49.84, 49.84) (1 samples)

16:42:37.88     Bars: 5

16:42:37.88    Profile Max Performance[2 players] =  0.02 0.03 0.02 0.03 0.03
16:42:37.88    Profile Avg Performance[2 players] =  0.02 0.02 0.02 0.02 0.02
16:42:37.88    VoiceInternal::UnregisterRemoteTalker remote talker 2533274836636513 doesn't exist, bailing
16:42:37.88    LiveOnPeerRemoveAsync removed playerID 2533274836636513 as Remote player
16:42:37.88    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2122MB] Used [147MB].
16:42:37.98    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:42:37.99    GameObj::ShutdownGameObj
16:42:37.99    GAME -- Beginning FE
16:42:37.99    GAME -- Ending mission - 'Sign In Change'
16:42:38.08    LiveCall: Session Delete failed : ([0x800704cd] - )
16:42:38.09    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:42:38.09    RemoveAllPeers - flushing local session peer data
16:42:38.09    Session::Reset with reason 999 and PartyInternal::RemoveAllPeers
16:42:38.09    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
16:42:38.09    PeerRemoveAll - flushing local session peer data
16:42:38.09    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
16:42:38.15    MessageInternal::DestroyChannel: Destroyed channel MODM
16:42:38.72    SOUND -- Flushing cache ...
16:42:38.75    SOUND -- Flush complete!
16:42:38.75    CRCBlockManager Max Count: 13
16:42:38.75    MessageInternal::DestroyChannel: Destroyed channel GMCC
16:42:38.75    MessageInternal::DestroyChannel: Destroyed channel SYNC
16:42:38.85    ScaleformFrontEnd::Process - preloading task complete
16:42:38.85    starting fe
16:42:38.85    ScaleformFrontEnd - Loading Front End
16:42:42.31    LiveTransport::Update unable to determined XNADDR for local peer
16:42:42.35    LiveTransport::Update unable to determined XNADDR for local peer
16:42:42.37    LiveTransport::Update unable to determined XNADDR for local peer
16:42:42.39    LiveTransport::Update unable to determined XNADDR for local peer
16:42:42.41    LiveTransport::Update unable to determined XNADDR for local peer
16:42:42.43    LiveTransport::Update unable to determined XNADDR for local peer
16:42:42.45    LiveTransport::Update unable to determined XNADDR for local peer
16:42:42.47    LiveTransport::Update unable to determined XNADDR for local peer
16:42:43.15    starting fe done
16:42:43.15    ScaleformFrontEnd::Process - threaded loading task complete
16:42:43.24    FactoryT - CreateForm transition_movie
16:42:43.25    FactoryT - CreateForm main_menu
16:42:43.25    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:42:43.31    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2242MB] Used [27MB].
16:42:43.35    FactoryT - CreateForm news
16:42:46.36    Got XN_SYS_UI - guide enabled
16:42:54.05    XNetGetTitleXnAddr changed our reporting address
16:42:54.70    LiveAccountService:OnSignInChanged, clearing profile settings.
16:42:54.70    Updating local user id
16:42:54.72    OnConnect: successful connection established, enabling reconnect
16:42:54.72    OnConnect: this wasnt a reconnect, no need for autologin
16:43:04.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:43:42.14    Got XN_SYS_UI - guide disabled
16:43:44.58    FactoryT - CreateForm gamehistory_tabs
16:43:44.62    FactoryT - CreateForm gamehistory_replays
16:43:44.79    GAME -- Error reading header for recorded game PLAYBACK:eas vs gaddy 1.rec
16:43:44.88    GAME -- Error reading header for recorded game PLAYBACK:eas vs gaddy 2.rec
16:43:46.22    FactoryT - CreateForm gamehistory_stats
16:43:52.32    FactoryT - CreateForm main_menu
16:43:52.32    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2178MB] Used [91MB].
16:43:52.36    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [2269MB] Available [2236MB] Used [33MB].
16:43:52.38    FactoryT - CreateForm news
16:44:05.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:45:00.71    LiveTransport::Update unable to determined XNADDR for local peer
16:45:00.73    LiveTransport::Update unable to determined XNADDR for local peer
16:45:00.75    LiveTransport::Update unable to determined XNADDR for local peer
16:45:00.77    LiveTransport::Update unable to determined XNADDR for local peer
16:45:00.79    LiveTransport::Update unable to determined XNADDR for local peer
16:45:00.82    LiveTransport::Update unable to determined XNADDR for local peer
16:45:01.03    LiveAccountService:OnSignInChanged, clearing profile settings.
16:45:01.03    Updating local user id
16:45:01.04    OnConnect: connect failure
16:45:01.04    OnConnect: this wasnt a reconnect, no need for autologin
16:45:05.79    LiveTransport::Update unable to determined XNADDR for local peer
16:45:05.81    LiveTransport::Update unable to determined XNADDR for local peer
16:45:05.83    LiveTransport::Update unable to determined XNADDR for local peer
16:45:05.85    LiveTransport::Update unable to determined XNADDR for local peer
16:45:05.87    LiveTransport::Update unable to determined XNADDR for local peer
16:45:05.89    LiveTransport::Update unable to determined XNADDR for local peer
16:45:06.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:46:07.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:47:08.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:48:02.21    VIDEO -- Texture Memory Start Device Reset: Video  [512MB] Total [2269MB] Available [2269MB] Used [0MB].
16:48:02.27    VIDEO -- Texture Memory End Device Reset: Video  [512MB] Total [2269MB] Available [2223MB] Used [46MB].
16:48:04.19    Got XN_SYS_UI - guide enabled
16:48:09.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:48:11.61    XNetGetTitleXnAddr changed our reporting address
16:48:12.26    OnConnect: successful connection established, enabling reconnect
16:48:12.26    OnConnect: this wasnt a reconnect, no need for autologin
16:48:12.50    LiveAccountService:OnSignInChanged, clearing profile settings.
16:48:12.50    Updating local user id
16:48:21.55    Got XN_SYS_UI - guide disabled
16:49:10.02    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:50:11.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:51:12.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:52:13.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:53:14.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:54:15.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:55:16.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
16:56:17.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 3/0, total = 6/0, max unsent 0, version mismatches 0 and blocked 0
