08:58:09.98    -- DOW2 Warnings Log --
08:58:09.98    DOW2 started at 2009-01-21 08:58
08:58:09.98    OS NT 5.1, 3072MB Physical Memory, 2314 Physical Available, 1102 Virtual Available
08:58:09.98    RUN OPTIONS: -logs 
08:58:09.98    WORKING DIR: 'c:\program files\steam\steamapps\common\warhammer 40,000 dawn of war ii - beta'
08:58:09.98    USER: 'ghost'
08:58:10.15    MOD -- Initializing mod 'DOW2', version '1.0', locale 'german'.
08:58:10.76    APP - Multi-threading Enabled
08:58:10.76    XTHREAD: Detected 2 core(s) with 2 hardware thread(s)
08:58:10.87    NetworkManager::Create - creating network manager
08:58:19.57    Transport::Connection request to live://255.255.255.255,0.0.0.0?port=1001?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
08:58:19.57    Transport::Connection request to live://0.0.0.1,0.0.0.0?port=1000?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
08:58:19.57    Net::ThreadFunction - Entering network thread function...
08:58:19.57    MessageInternal::CreateChannel: Created channel GSTP
08:58:19.57    Session::Initialize - info, initializing session object, using threads.
08:58:19.57    Transport::Connection request to live://255.255.255.255,0.0.0.0?port=1001?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
08:58:19.57    AutomatchInternal: Instantiating
08:58:19.57    PartyInternal: Instantiating
08:58:19.57    MessageInternal::CreateChannel: Created channel PRTY
08:58:19.57    MessageInternal::CreateChannel: Created channel QCKM
08:58:19.57    Session::Initialize - info, initializing session object, using threads.
08:58:19.57    Transport::Connection request to live://255.255.255.255,0.0.0.0?port=1001?mac=AAAAAAAA?abOnline=AAAAAAAAAAAAAAAAAAAAAAAAAAA=?XnKid=AAAAAAAAAAA=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
08:58:19.60    GAME -- Dawn of War 2, 0.0, Build DOW2-MPDEMO.1.0.2958
08:58:20.28    ShaderDatabase : shader [DATA:Shaders\TERRAINOVERLAY.SHADER] specifies an undefined inputlayout terrainbasemesh.
08:58:20.46    VIDEO -- Driver Name = nv4_disp.dll  Desc = NVIDIA GeForce 8600 GTS
08:58:20.46    VIDEO -- Driver Vendor = 0x10DE  Device = 0x0400  SubSys = 0x08911462  Rev = 0x00A1
08:58:20.46    VIDEO -- Driver Version  Product = 0x0006  Version = 0x000E  SubVersion = 0x000B  Build = 0x1E85 (7813)
08:58:20.46    VIDEO -- Driver GUID = {D7B71E3E-4740-11CF-5769-9A2800C2CB35}
08:58:23.00    Largest sent is now 56
08:58:23.20    VIDEO -- Detected Display Video Memory [512MB]
08:58:23.21    VIDEO - Old NVIDIA video drivers without application registration support detected,installing more recent drivers will provide better performance
08:58:23.21    VIDEO - NVIDIA card memory, dedicated [65552MB], system [512MB], shared [0MB]
08:58:23.21    VIDEO -- Dedicated Video Memory [512MB]
08:58:23.21    VIDEO -- Graphics Card Memory [512MB] Texture Memory Available [723MB].
08:58:23.21    VIDEO - Using shader profile 'sm3'
08:58:23.25    SHADER -- variable [g_bPostProcessingEnabled] declared in [effectpool.shader] but not in .fx.
08:58:23.25    SHADER -- variable [g_useTerrainLightmap] declared in [effectpool.shader] but not in .fx.
08:58:23.29    SHADER -- variable [textureSize] declared in [terrain_splatongeometry.shader] but not in .fx.
08:58:23.87    VIDEO -- Texture Memory Start Device Reset: Video  [512MB] Total [723MB] Available [695MB] Used [28MB].
08:58:23.90    VIDEO -- Texture Memory End Device Reset: Video  [512MB] Total [723MB] Available [691MB] Used [32MB].
08:58:25.92    SOUND -- FMOD System Initializing...
08:58:25.95    SOUND -- Speaker output configuration set to 7.1
08:58:25.95    SOUND -- FMOD System Initialized on device SB X-Fi Audio [DF00].
08:58:26.48    SOUND -- SIR Filter 1 initialized
08:58:26.48    SOUND -- SIR Filter 2 initialized
08:58:26.48    SOUND -- Initializing ...
08:58:26.50    SOUND -- 96 voices selected, using 96 LOD settings
08:58:26.57    SOUND -- Initialization completed!
08:58:26.62    CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
08:58:26.62    GAME -- Beginning FE
08:58:26.62    starting fe
08:58:26.62    ScaleformFrontEnd - Loading Front End
08:58:26.98    starting fe done
08:58:26.98    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [685MB] Used [38MB].
08:58:27.00    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [685MB] Used [38MB].
08:58:27.00    APP -- Resetting fp control word.
08:58:27.10    SOUND - Shark Thread - Pause received
08:58:27.10    SOUND - Shark Thread - UnPause received
08:58:27.14    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_statslevel.php?name=DOW2
08:58:30.10    XNetGetTitleXnAddr changed our reporting address
08:58:30.78    OnConnect: successful connection established, enabling reconnect
08:58:30.78    OnConnect: this wasnt a reconnect, no need for autologin
08:58:30.87    LiveAccountService:OnSignInChanged, clearing profile settings.
08:58:30.89    OnLogin: no previous login, auto selecting profile not required
08:58:31.03    Profile [00090000:02a66ed7] selected on controller#0
08:58:31.06    LiveGetProfileSettingsAsync - setting profile settings.
08:58:31.06     ProfileInfo version mismatch, skipping version profile info read.
08:58:33.96    SOUND - Shark Thread - Pause received
08:58:33.96    SOUND - Shark Thread - UnPause received
08:58:34.01    SOUND - Shark Thread - Pause received
08:58:34.01    SOUND - Shark Thread - UnPause received
08:58:40.25    SOUND - Shark Thread - Pause received
08:58:40.25    SOUND - Shark Thread - UnPause received
08:58:40.34    SOUND - Shark Thread - Pause received
08:58:40.34    SOUND - Shark Thread - UnPause received
08:58:43.57    SOUND - Shark Thread - Pause received
08:58:43.57    SOUND - Shark Thread - UnPause received
08:58:43.62    SOUND - Shark Thread - Pause received
08:58:43.62    SOUND - Shark Thread - UnPause received
08:58:45.57    SOUND - Shark Thread - Pause received
08:58:45.57    SOUND - Shark Thread - UnPause received
08:58:45.67    SOUND - Shark Thread - Pause received
08:58:45.67    SOUND - Shark Thread - UnPause received
08:58:53.29    SOUND - Shark Thread - Pause received
08:58:53.29    SOUND - Shark Thread - UnPause received
08:58:53.40    SOUND - Shark Thread - Pause received
08:58:53.40    SOUND - Shark Thread - UnPause received
08:59:19.00    Transport::Update median kBPS [highest/current] sent = 0/0, recvd = 0/0, total = 0/0, max unsent 0, version mismatches 0 and blocked 0
09:00:20.00    Transport::Update median kBPS [highest/current] sent = 0/0, recvd = 0/0, total = 0/0, max unsent 0, version mismatches 0 and blocked 0
09:01:21.00    Transport::Update median kBPS [highest/current] sent = 0/0, recvd = 0/0, total = 0/0, max unsent 0, version mismatches 0 and blocked 0
09:01:24.51    SOUND - Shark Thread - Pause received
09:01:24.51    SOUND - Shark Thread - UnPause received
09:01:33.76    PBGM Loaded in 9.173000 seconds.
09:01:33.89    GAME -- Using player profile EXITUS-82A6C518
09:01:39.57    FactoryT - CreateForm transition_movie
09:01:39.59    FactoryT - CreateForm main_menu
09:01:45.07    FactoryT - CreateForm options_form
09:02:06.89    FactoryT - CreateForm main_menu
09:02:11.31    Created Partyinfo
09:02:11.31    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:02:12.54    OnServiceJoinSuccess - joined online party, server leave notification required
09:02:12.54    starting local hosting
09:02:12.54    Transport::Connection request to live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAG3MW8/M5k=?XnKey=rbonqoFusj18yDzZ9fydhQ==
09:02:12.54    ValidateCustomData: called with 119 bytes of custom data
09:02:12.54    Host accepted Peer 1 into the match at address live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAG3MW8/M5k=?XnKey=rbonqoFusj18yDzZ9fydhQ==
09:02:12.54    PartyInternal::Process - EVENT_NEWPEER
09:02:12.54    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
09:02:12.56    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
09:02:12.57    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
09:02:12.57    hosting - Session is connected
09:02:12.60    hosting completed successfully
09:02:12.60    HostAsync - completed with HostResult = 0
09:02:12.65    FactoryT - CreateForm matchmaking
09:02:12.65    MessageInternal::CreateChannel: Created channel SMSG
09:02:12.65    RankManager::GetLocalPlayerExp can't ask again yet, bailing
09:02:12.65    MessageInternal::CreateChannel: Created channel PPGM
09:02:12.70    FactoryT - CreateForm chat_panel
09:02:12.70    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/chat_panel.gfx
09:02:12.70    FactoryT - CreateForm party_panel
09:02:12.71    RankManager::GetLocalPlayerExp can't ask again yet, bailing
09:02:12.71    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/party_panel.gfx
09:02:12.71    FactoryT - CreateForm hero_selection_panel
09:02:12.75    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/hero_selection_panel.gfx
09:02:12.75    Hero sbps\pvp\race_tyranid\heroes\tyr_hive_tyrant has been selected
09:02:12.79    FactoryT - CreateForm game_options_panel
09:02:12.79    MatchMakingForm::OnChildAdded - added child DATA:ui/movies/front_end/game_options_panel.gfx
09:02:13.34    destLen = 255
09:02:22.00    Transport::Update median kBPS [highest/current] sent = 0/0, recvd = 0/0, total = 0/0, max unsent 0, version mismatches 0 and blocked 0
09:03: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
09:03:23.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
09:03:23.78    QuickMatchInternal - StartPolling
09:03:23.78    Set state; QuickMatchInternal::S_Searching 
09:03:23.79    PostPollEvent - host state = QuickMatchInternal::S_Searching
09:03:23.79    Host state; QuickMatchInternal::S_Searching 
09:03:28.35    QuickMatchInternal - Found a match, trying to join.
09:03:28.35    Set state; QuickMatchInternal::S_Joining 
09:03:28.37    JoinAsync: Starting AsyncJob...
09:03:28.37    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:03:28.37    Created Matchinfo
09:03:28.37    PostPollEvent - host state = QuickMatchInternal::S_Joining
09:03:28.37    Host state; QuickMatchInternal::S_Joining 
09:03:28.43    OnlineJoinAsync success
09:03:28.43    OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:03:28.45    Transport::Connection request to live://192.168.2.103,87.154.131.235?port=524?mac=ALXKPliG?abOnline=Cv4QAQAeZLbJQxIAAAAA+wIAAAA=?XnKid=gATWFHYYFEc=?XnKey=M4FUBrKqAm3VI3/oE0M8Og==
09:03:28.45    Transport::Connection request to live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gATWFHYYFEc=?XnKey=M4FUBrKqAm3VI3/oE0M8Og==
09:03:28.45    Session::Connect host address live://192.168.2.103,87.154.131.235?port=524?mac=ALXKPliG?abOnline=Cv4QAQAeZLbJQxIAAAAA+wIAAAA=?XnKid=gATWFHYYFEc=?XnKey=M4FUBrKqAm3VI3/oE0M8Og==
09:03:28.46    Largest sent is now 389
09:03:28.90    Largest received is now 61
09:03:28.92    Largest received is now 192
09:03:28.92    Closed connection by remote request for PeerID 0 at live://192.168.2.103,87.154.131.235?port=524?mac=ALXKPliG?abOnline=Cv4QAQAeZLbJQxIAAAAA+wIAAAA=?XnKid=gATWFHYYFEc=?XnKey=M4FUBrKqAm3VI3/oE0M8Og==
09:03:28.95    Closed connection for PeerID 0 at live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gATWFHYYFEc=?XnKey=M4FUBrKqAm3VI3/oE0M8Og==
09:03:28.95    Closed connection for PeerID 0 at live://192.168.2.103,87.154.131.235?port=524?mac=ALXKPliG?abOnline=Cv4QAQAeZLbJQxIAAAAA+wIAAAA=?XnKid=gATWFHYYFEc=?XnKey=M4FUBrKqAm3VI3/oE0M8Og==
09:03:28.95    JoinAsync - got operation info 112:match is not joinable
09:03:28.96    PeerRemoveAll - flushing local session peer data
09:03:28.96    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:03:28.96    Destroyed Matchinfo
09:03:28.96    JoinAsync - completed with JoinResult = 26:JoinEvent::R_NotJoinable
09:03:28.96    AutomatchInternal::OnJoinComplete - Completed Join with success=0
09:03:28.96    AutomatchInternal::OnJoinComplete - automatcher is no longer active - ignoring
09:03:28.96    OnJoinComplete - join complete.
09:03:28.96    QuickMatchInternal::OnJoinComplete - Failed to join, marking match as bad
09:03:28.96    Set state; QuickMatchInternal::S_Searching 
09:03:28.96    JoinAsync: AsyncJob Complete...
09:03:28.96    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:03:28.96    PostPollEvent - host state = QuickMatchInternal::S_Searching
09:03:28.96    Host state; QuickMatchInternal::S_Searching 
09:03:33.00    QuickMatchInternal - Found a match, trying to join.
09:03:33.00    Set state; QuickMatchInternal::S_Joining 
09:03:33.01    JoinAsync: Starting AsyncJob...
09:03:33.01    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:03:33.01    Created Matchinfo
09:03:33.01    PostPollEvent - host state = QuickMatchInternal::S_Joining
09:03:33.01    Host state; QuickMatchInternal::S_Joining 
09:03:33.09    OnlineJoinAsync success
09:03:33.09    OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:03:33.10    Transport::Connection request to live://10.1.1.7,219.89.56.99?port=40134?mac=ANRqoqd7?abOnline=Cv4XAQAvgtegMBIAAAAA+wIAAAA=?XnKid=gATZT65dXAQ=?XnKey=U4wP8Eb3vyFvRdvNL4WOVA==
09:03:33.10    Transport::Connection request to live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gATZT65dXAQ=?XnKey=U4wP8Eb3vyFvRdvNL4WOVA==
09:03:33.10    Session::Connect host address live://10.1.1.7,219.89.56.99?port=40134?mac=ANRqoqd7?abOnline=Cv4XAQAvgtegMBIAAAAA+wIAAAA=?XnKid=gATZT65dXAQ=?XnKey=U4wP8Eb3vyFvRdvNL4WOVA==
09:03:34.01    Closed connection by remote request for PeerID 0 at live://10.1.1.7,219.89.56.99?port=40134?mac=ANRqoqd7?abOnline=Cv4XAQAvgtegMBIAAAAA+wIAAAA=?XnKid=gATZT65dXAQ=?XnKey=U4wP8Eb3vyFvRdvNL4WOVA==
09:03:34.04    Closed connection for PeerID 0 at live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gATZT65dXAQ=?XnKey=U4wP8Eb3vyFvRdvNL4WOVA==
09:03:34.04    Closed connection for PeerID 0 at live://10.1.1.7,219.89.56.99?port=40134?mac=ANRqoqd7?abOnline=Cv4XAQAvgtegMBIAAAAA+wIAAAA=?XnKid=gATZT65dXAQ=?XnKey=U4wP8Eb3vyFvRdvNL4WOVA==
09:03:34.06    JoinAsync - got operation info 112:match is not joinable
09:03:34.07    PeerRemoveAll - flushing local session peer data
09:03:34.07    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:03:34.07    Destroyed Matchinfo
09:03:34.07    JoinAsync - completed with JoinResult = 26:JoinEvent::R_NotJoinable
09:03:34.07    AutomatchInternal::OnJoinComplete - Completed Join with success=0
09:03:34.07    AutomatchInternal::OnJoinComplete - automatcher is no longer active - ignoring
09:03:34.07    OnJoinComplete - join complete.
09:03:34.07    QuickMatchInternal::OnJoinComplete - Failed to join, marking match as bad
09:03:34.07    Set state; QuickMatchInternal::S_Searching 
09:03:34.07    JoinAsync: AsyncJob Complete...
09:03:34.07    PostPollEvent - host state = QuickMatchInternal::S_Searching
09:03:34.07    Host state; QuickMatchInternal::S_Searching 
09:03:34.07    Transport::ProcessConnections - Expected ConnectionID 6 doesn't exist, will close remote.
09:03:34.07    Session - XSocketSendTo failed, unreachable, closing connections
09:03:38.00    QuickMatchInternal - Found a match, trying to join.
09:03:38.00    Set state; QuickMatchInternal::S_Joining 
09:03:38.01    JoinAsync: Starting AsyncJob...
09:03:38.01    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:03:38.01    Created Matchinfo
09:03:38.03    PostPollEvent - host state = QuickMatchInternal::S_Joining
09:03:38.03    Host state; QuickMatchInternal::S_Joining 
09:03:38.09    OnlineJoinAsync success
09:03:38.09    OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:03:38.10    Transport::Connection request to live://192.168.1.103,76.87.166.149?port=524?mac=AAFeus2t?abOnline=Cv46AQADcUyePBIAAAAA+wIAAAA=?XnKid=gAQwBViSNLY=?XnKey=rFKsttvinH2Li2KYpR1KYw==
09:03:38.10    Transport::Connection request to live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAQwBViSNLY=?XnKey=rFKsttvinH2Li2KYpR1KYw==
09:03:38.10    Session::Connect host address live://192.168.1.103,76.87.166.149?port=524?mac=AAFeus2t?abOnline=Cv46AQADcUyePBIAAAAA+wIAAAA=?XnKid=gAQwBViSNLY=?XnKey=rFKsttvinH2Li2KYpR1KYw==
09:03:38.71    Closed connection by remote request for PeerID 0 at live://192.168.1.103,76.87.166.149?port=524?mac=AAFeus2t?abOnline=Cv46AQADcUyePBIAAAAA+wIAAAA=?XnKid=gAQwBViSNLY=?XnKey=rFKsttvinH2Li2KYpR1KYw==
09:03:38.75    Closed connection for PeerID 0 at live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAQwBViSNLY=?XnKey=rFKsttvinH2Li2KYpR1KYw==
09:03:38.75    Closed connection for PeerID 0 at live://192.168.1.103,76.87.166.149?port=524?mac=AAFeus2t?abOnline=Cv46AQADcUyePBIAAAAA+wIAAAA=?XnKid=gAQwBViSNLY=?XnKey=rFKsttvinH2Li2KYpR1KYw==
09:03:38.75    JoinAsync - got operation info 112:match is not joinable
09:03:38.76    PeerRemoveAll - flushing local session peer data
09:03:38.76    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:03:38.76    Destroyed Matchinfo
09:03:38.76    JoinAsync - completed with JoinResult = 26:JoinEvent::R_NotJoinable
09:03:38.76    AutomatchInternal::OnJoinComplete - Completed Join with success=0
09:03:38.76    AutomatchInternal::OnJoinComplete - automatcher is no longer active - ignoring
09:03:38.76    OnJoinComplete - join complete.
09:03:38.76    QuickMatchInternal::OnJoinComplete - Failed to join, marking match as bad
09:03:38.76    Set state; QuickMatchInternal::S_Searching 
09:03:38.76    JoinAsync: AsyncJob Complete...
09:03:38.76    PostPollEvent - host state = QuickMatchInternal::S_Searching
09:03:38.78    Host state; QuickMatchInternal::S_Searching 
09:03:43.00    QuickMatchInternal - No matches found, trying to host.
09:03:43.00    Set state; QuickMatchInternal::S_Hosting 
09:03:43.01    Created Matchinfo
09:03:43.01    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:03:43.01    starting online hosting
09:03:43.01    PostPollEvent - host state = QuickMatchInternal::S_Hosting
09:03:43.01    Host state; QuickMatchInternal::S_Hosting 
09:03:44.20    OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:03:44.20    starting local hosting
09:03:44.20    Transport::Connection request to live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAT3l7zSQx8=?XnKey=YXj0DpUgnSydCATG0EAshg==
09:03:44.20    ValidateCustomData: called with 267 bytes of custom data
09:03:44.20    Host accepted Peer 1 into the match at address live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAT3l7zSQx8=?XnKey=YXj0DpUgnSydCATG0EAshg==
09:03:44.20    AdvertisementInternal::Process - EVENT_NEWPEER
09:03:44.20    LiveOnPeerAddAsync added playerID 2533274834857687 as Local player in index 0
09:03:44.20    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
09:03:44.23    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
09:03:44.23    hosting - Session is connected
09:03:44.23    Net::Session::SetVisible - session is set to VISIBLE.
09:03:44.25    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
09:03:44.25    hosting completed successfully
09:03:44.25    HostAsync - completed with HostResult = 0
09:03:44.25    AutomatchInternal::OnHostComplete - Completed Host with success=1
09:03:44.25    AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
09:03:44.25    QuickMatchInternal::OnHostComplete - Host complete.
09:03:44.25    Set state; QuickMatchInternal::S_Waiting 
09:03:44.25    PostPollEvent - host state = QuickMatchInternal::S_Waiting
09:03:44.25    Host state; QuickMatchInternal::S_Waiting 
09:03:44.26    PostPollEvent - host state = QuickMatchInternal::S_Waiting
09:03:44.26    Host state; QuickMatchInternal::S_Waiting 
09:03:44.28    destLen = 331
09:03:48.00    QuickMatchInternal - Found a better match, firing the disconnect and join job.
09:03:48.00    Set state; QuickMatchInternal::S_Joining 
09:03:48.01    Session is marking the local peer PeerID 1 for death
09:03:48.01    Closed connection for PeerID 1 at live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAT3l7zSQx8=?XnKey=YXj0DpUgnSydCATG0EAshg==
09:03:48.01    AdvertisementInternal::Process - EVENT_DESTROYPEER
09:03:48.01    LeaveMatchInternal - no action taken, needLeave=0, service=0
09:03:48.01    Destroyed Matchinfo
09:03:48.01    PostPollEvent - host state = QuickMatchInternal::S_Joining
09:03:48.01    Host state; QuickMatchInternal::S_Joining 
09:03:48.03    LiveOnPeerRemoveAsync removed playerID 2533274834857687 as Local player in index 0
09:03:48.67    Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:03:48.67    PeerRemoveAll - flushing local session peer data
09:03:48.67    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:03:48.68    JoinAsync: Starting AsyncJob...
09:03:48.68    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:03:48.68    Created Matchinfo
09:03:48.75    OnlineJoinAsync success
09:03:48.75    OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:03:48.76    Transport::Connection request to live://10.225.252.24,216.9.17.130?port=524?mac=ADZckFzN?abOnline=Cv5CAQDcuC/ZPxIAAAAA+wIAAAA=?XnKid=gATrLs9G4EE=?XnKey=JuZfiUQWiEqrr1uFd/ALsA==
09:03:48.76    Transport::Connection request to live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gATrLs9G4EE=?XnKey=JuZfiUQWiEqrr1uFd/ALsA==
09:03:48.76    Session::Connect host address live://10.225.252.24,216.9.17.130?port=524?mac=ADZckFzN?abOnline=Cv5CAQDcuC/ZPxIAAAAA+wIAAAA=?XnKid=gATrLs9G4EE=?XnKey=JuZfiUQWiEqrr1uFd/ALsA==
09:03:48.78    Largest sent is now 413
09:03:49.35    Largest received is now 216
09:03:49.35    Closed connection by remote request for PeerID 0 at live://10.225.252.24,216.9.17.130?port=524?mac=ADZckFzN?abOnline=Cv5CAQDcuC/ZPxIAAAAA+wIAAAA=?XnKid=gATrLs9G4EE=?XnKey=JuZfiUQWiEqrr1uFd/ALsA==
09:03:49.37    Closed connection for PeerID 0 at live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gATrLs9G4EE=?XnKey=JuZfiUQWiEqrr1uFd/ALsA==
09:03:49.37    Closed connection for PeerID 0 at live://10.225.252.24,216.9.17.130?port=524?mac=ADZckFzN?abOnline=Cv5CAQDcuC/ZPxIAAAAA+wIAAAA=?XnKid=gATrLs9G4EE=?XnKey=JuZfiUQWiEqrr1uFd/ALsA==
09:03:49.39    JoinAsync - got operation info 112:match is not joinable
09:03:49.40    PeerRemoveAll - flushing local session peer data
09:03:49.40    Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:03:49.40    Destroyed Matchinfo
09:03:49.40    JoinAsync - completed with JoinResult = 26:JoinEvent::R_NotJoinable
09:03:49.40    AutomatchInternal::OnJoinComplete - Completed Join with success=0
09:03:49.40    AutomatchInternal::OnJoinComplete - automatcher is no longer active - ignoring
09:03:49.40    OnJoinComplete - join complete.
09:03:49.40    QuickMatchInternal::OnJoinComplete - Failed to join, marking match as bad
09:03:49.40    Set state; QuickMatchInternal::S_Searching 
09:03:49.40    JoinAsync: AsyncJob Complete...
09:03:49.40    PostPollEvent - host state = QuickMatchInternal::S_Searching
09:03:49.40    Host state; QuickMatchInternal::S_Searching 
09:03:53.00    QuickMatchInternal - No matches found, trying to host.
09:03:53.00    Set state; QuickMatchInternal::S_Hosting 
09:03:53.01    Created Matchinfo
09:03:53.01    Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:03:53.01    starting online hosting
09:03:53.01    PostPollEvent - host state = QuickMatchInternal::S_Hosting
09:03:53.01    Host state; QuickMatchInternal::S_Hosting 
09:03:53.65    OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:03:53.65    starting local hosting
09:03:53.65    Transport::Connection request to live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:03:53.65    ValidateCustomData: called with 415 bytes of custom data
09:03:53.65    Host accepted Peer 1 into the match at address live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:03:53.65    AdvertisementInternal::Process - EVENT_NEWPEER
09:03:53.65    LiveOnPeerAddAsync added playerID 2533274834857687 as Local player in index 0
09:03:53.65    Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
09:03:53.67    Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
09:03:53.67    hosting - Session is connected
09:03:53.67    Net::Session::SetVisible - session is set to VISIBLE.
09:03:53.68    hosting completed successfully
09:03:53.68    HostAsync - completed with HostResult = 0
09:03:53.68    AutomatchInternal::OnHostComplete - Completed Host with success=1
09:03:53.68    AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
09:03:53.68    QuickMatchInternal::OnHostComplete - Host complete.
09:03:53.68    Set state; QuickMatchInternal::S_Waiting 
09:03:53.68    PostPollEvent - host state = QuickMatchInternal::S_Waiting
09:03:53.68    Host state; QuickMatchInternal::S_Waiting 
09:03:53.68    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
09:03:53.71    destLen = 338
09:03:58.01    PostPollEvent - host state = QuickMatchInternal::S_Waiting
09:03:58.01    Host state; QuickMatchInternal::S_Waiting 
09:03:59.85    Largest received is now 385
09:03:59.85    Transport::Connection request to live://192.168.1.2,78.32.72.211?port=524?mac=ADvxBJ6A?abOnline=Cv4rAQBRD0JcPRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
09:03:59.90    Transport::Connection request to live://192.168.1.2,78.32.72.211?port=524?mac=ADvxBJ6A?abOnline=Cv4rAQBRD0JcPRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:03:59.92    ValidateCustomData: called with 399 bytes of custom data
09:03:59.92    Host accepted Peer 2 into the match at address live://192.168.1.2,78.32.72.211?port=524?mac=ADvxBJ6A?abOnline=Cv4rAQBRD0JcPRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:03:59.92    AdvertisementInternal::Process - EVENT_NEWPEER
09:03:59.92    LiveOnPeerAddAsync added playerID 2533274827398721 as Remote player
09:03:59.93    Largest sent is now 468
09:03:59.93    PostPollEvent - host state = QuickMatchInternal::S_Waiting
09:03:59.93    Host state; QuickMatchInternal::S_Waiting 
09:03:59.96    destLen = 358
09:04:00.21    Station [0:2] acknowledged matchinfo change #21
09:04:00.23    Largest sent is now 474
09:04:00.23    Station [0:2] acknowledged matchinfo change #23
09:04:00.26    destLen = 367
09:04:00.53    Station [0:2] acknowledged matchinfo change #24
09:04:00.53    Station [0:2] acknowledged matchinfo change #26
09:04:00.53    QuickMatchInternal::OnQMMT_StartGame_To_Everyone - Got a start game.
09:04:00.53    MechaMeesh is now muted
09:04:00.53    RankManager::GetLocalPlayerExp can't ask again yet, bailing
09:04:00.54    LiveAdvertisement::SetJoinable, match doesn't use presence, nothing to do
09:04:00.54    MechaMeesh is now muted
09:04:00.56    GetMaxFrameTimeFromProfile: players=2 expected FPS=5.713286, bars=1, max avg=0.157, sd=0.018, 3 samples =  0.14 0.15 0.18
09:04:00.56    Set state; QuickMatchInternal::S_Starting 
09:04:00.57    PostPollEvent - host state = QuickMatchInternal::S_Starting
09:04:00.57    Host state; QuickMatchInternal::S_Starting 
09:04:00.57    QuickMatchInternal - StopPolling with state=QuickMatchInternal::S_Starting
09:04:00.57    Set state; QuickMatchInternal::S_Idle 
09:04:00.59    PostPollEvent - host state = QuickMatchInternal::S_Idle
09:04:00.59    Host state; QuickMatchInternal::S_Idle 
09:04:00.60    Largest sent is now 482
09:04:00.81    Largest sent is now 484
09:04:00.85    Station [0:2] acknowledged matchinfo change #29
09:04:01.03    destLen = 376
09:04:01.09    Station [0:2] acknowledged matchinfo change #32
09:04:01.46    Largest received is now 394
09:04:01.46    Transport::Connection request to live://192.168.2.101,217.255.220.67?port=524?mac=APVEneKL?abOnline=Cv4UAQD6uzsmRxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
09:04:01.51    Transport::Connection request to live://192.168.2.101,217.255.220.67?port=524?mac=APVEneKL?abOnline=Cv4UAQD6uzsmRxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:01.51    ValidateCustomData: called with 393 bytes of custom data
09:04:01.51    Session denying join, reason 112 reasonDebug match is not joinable
09:04:01.51    Closed connection for PeerID 3 at live://192.168.2.101,217.255.220.67?port=524?mac=APVEneKL?abOnline=Cv4UAQD6uzsmRxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:01.54    Largest received is now 398
09:04:01.54    Transport::Connection request to live://192.168.2.10,69.157.146.105?port=524?mac=AMRmesDG?abOnline=Cv4JAQB+agqlPBIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
09:04:01.59    Transport::Connection request to live://192.168.2.10,69.157.146.105?port=524?mac=AMRmesDG?abOnline=Cv4JAQB+agqlPBIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:01.59    ValidateCustomData: called with 407 bytes of custom data
09:04:01.59    Session denying join, reason 112 reasonDebug match is not joinable
09:04:01.59    Closed connection for PeerID 4 at live://192.168.2.10,69.157.146.105?port=524?mac=AMRmesDG?abOnline=Cv4JAQB+agqlPBIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:01.82    Transport::Connection request to live://192.168.2.10,69.157.146.105?port=524?mac=AMRmesDG?abOnline=Cv4JAQB+agqlPBIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:01.84    ValidateCustomData: called with 407 bytes of custom data
09:04:01.84    Session denying join, reason 112 reasonDebug match is not joinable
09:04:01.84    Closed connection for PeerID 5 at live://192.168.2.10,69.157.146.105?port=524?mac=AMRmesDG?abOnline=Cv4JAQB+agqlPBIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:02.75    Transport::Connection request to live://192.168.0.4,66.68.250.203?port=524?mac=AHEoFD+c?abOnline=Cv4FAQBVAHAwOxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
09:04:02.79    Transport::Connection request to live://192.168.0.4,66.68.250.203?port=524?mac=AHEoFD+c?abOnline=Cv4FAQBVAHAwOxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:02.81    ValidateCustomData: called with 397 bytes of custom data
09:04:02.81    Session denying join, reason 112 reasonDebug match is not joinable
09:04:02.81    Closed connection for PeerID 6 at live://192.168.0.4,66.68.250.203?port=524?mac=AHEoFD+c?abOnline=Cv4FAQBVAHAwOxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:03.04    Transport::Connection request to live://192.168.0.4,66.68.250.203?port=524?mac=AHEoFD+c?abOnline=Cv4FAQBVAHAwOxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:03.04    ValidateCustomData: called with 397 bytes of custom data
09:04:03.04    Session denying join, reason 112 reasonDebug match is not joinable
09:04:03.04    Closed connection for PeerID 7 at live://192.168.0.4,66.68.250.203?port=524?mac=AHEoFD+c?abOnline=Cv4FAQBVAHAwOxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:05.87    Transport::Connection request to live://78.106.21.3,78.106.21.3?port=524?mac=AK2BmmhE?abOnline=Cv4zAQACLTrsQRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
09:04:05.92    Transport::Connection request to live://78.106.21.3,78.106.21.3?port=524?mac=AK2BmmhE?abOnline=Cv4zAQACLTrsQRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:05.92    ValidateCustomData: called with 231 bytes of custom data
09:04:05.92    Session denying join, reason 112 reasonDebug match is not joinable
09:04:05.92    Closed connection for PeerID 8 at live://78.106.21.3,78.106.21.3?port=524?mac=AK2BmmhE?abOnline=Cv4zAQACLTrsQRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:06.00    LiveAdvertisement::SetJoinable, match doesn't use presence, nothing to do
09:04:06.00    MatchInternal::SetMatchState - state 1 - updating server
09:04:06.00    Net::Session::SetVisible - session is set to INVISIBLE.
09:04:06.00    MatchSetup: Sending start game message!
09:04:06.00    GameSetupForm - Starting game
09:04:06.00    PopulateGameInfo - random seed:[1232525046], guid:[{5d7930c8-8588-4b75-86e5-2b4b2f03ba4c}], sync level:[0]
09:04:06.01    APP -- Game Start
09:04:06.14    GAME -- Ending FE
09:04:06.14    ScaleformFrontEnd - Unloading Front End
09:04:06.14    Transport::Connection request to live://78.106.21.3,78.106.21.3?port=524?mac=AK2BmmhE?abOnline=Cv4zAQACLTrsQRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:06.15    MessageInternal::DestroyChannel: Destroyed channel SMSG
09:04:06.20    MessageInternal::CreateChannel: Created channel SYNC
09:04:06.20    P2PNetworkSynchronization::RegisterPeer - info, registered local station [1].
09:04:06.20    P2PNetworkSynchronization::RegisterPeer - info, registered remote station [2].
09:04:06.20    MechaMeesh is now muted
09:04:06.20    MessageInternal::CreateChannel: Created channel GOBJ
09:04:06.20    GAME -- *** Beginning mission 2p_calderisdunes (2 Humans, 0 Computers) ***
09:04:06.20    GameObj::StartGameObj - info, network session GUID set to [{5d7930c8-8588-4b75-86e5-2b4b2f03ba4c}].
09:04:06.34    GAME -- Recording game
09:04:06.46    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [606MB] Used [117MB].
09:04:06.50    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [650MB] Used [73MB].
09:04:06.51    GAME -- Precaching Action
09:04:06.57    ValidateCustomData: called with 231 bytes of custom data
09:04:06.57    Session denying join, reason 112 reasonDebug match is not joinable
09:04:06.57    Closed connection for PeerID 9 at live://78.106.21.3,78.106.21.3?port=524?mac=AK2BmmhE?abOnline=Cv4zAQACLTrsQRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:06.73    Station [0:2] acknowledged matchinfo change #35
09:04:06.73    GameObjController - OnMatchEvent: event type 6
09:04:07.01    GAME -- Loading Animators
09:04:14.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
09:04:14.60    XSessionArbitrationRegister fine
09:04:15.34    XSessionStart fine
09:04:17.76    Transport::Connection request to live://192.168.2.2,70.174.68.16?port=524?mac=AOV+olaT?abOnline=Cv5BAQDTn6saNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=AAAAAAAAAAAAAAAAAAAAAA==
09:04:17.82    Transport::Connection request to live://192.168.2.2,70.174.68.16?port=524?mac=AOV+olaT?abOnline=Cv5BAQDTn6saNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:17.82    ValidateCustomData: called with 379 bytes of custom data
09:04:17.82    Session denying join, reason 112 reasonDebug match is not joinable
09:04:17.82    Closed connection for PeerID 10 at live://192.168.2.2,70.174.68.16?port=524?mac=AOV+olaT?abOnline=Cv5BAQDTn6saNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:17.95    Transport::Connection request to live://192.168.2.2,70.174.68.16?port=524?mac=AOV+olaT?abOnline=Cv5BAQDTn6saNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:17.95    ValidateCustomData: called with 379 bytes of custom data
09:04:17.95    Session denying join, reason 112 reasonDebug match is not joinable
09:04:17.95    Closed connection for PeerID 11 at live://192.168.2.2,70.174.68.16?port=524?mac=AOV+olaT?abOnline=Cv5BAQDTn6saNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:04:19.54    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:37002817, MechaMeesh]" finished loading with checksum [702919809].
09:04:21.56    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:37002817, MechaMeesh]" finished loading with checksum [702919809].
09:04:23.53    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:37002817, MechaMeesh]" finished loading with checksum [702919809].
09:04:24.00    Transport::Update median kBPS [highest/current] sent = 1/0, recvd = 1/0, total = 2/0, max unsent 0, version mismatches 0 and blocked 0
09:04:25.53    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:37002817, MechaMeesh]" finished loading with checksum [702919809].
09:04:26.06    ImpassMap Load CRC
09:04:26.06      :  1056964608
09:04:26.06      :  1059892375
09:04:26.06      :  1053609165
09:04:26.06      :  0
09:04:26.06      g: 425632575
09:04:26.06      f: 425632575
09:04:27.53    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:37002817, MechaMeesh]" finished loading with checksum [702919809].
09:04:27.65    MessageInternal::CreateChannel: Created channel GMCC
09:04:27.84    MessageInternal::CreateChannel: Created channel MODM
09:04:27.85    MOD UI - Invalid key combo (select_hero) found in data:config/TaskBar/keydefaults.lua.
09:04:29.56    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000002, pid 589824:37002817, MechaMeesh]" finished loading with checksum [702919809].
09:04:29.93    GAME -- Loading completed (23 seconds)
09:04:29.93    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [663MB] Used [60MB].
09:04:30.01    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [663MB] Used [60MB].
09:04:30.01    SIM -- Setting SyncErrorChecking level to Low
09:04:30.06    LoadArbitrator::UpdateLoadProgress - info, player "[sid 00000000:00000001, pid 589824:44461783, Tyrone Kox]" finished loading with checksum [702919809].
09:04:30.07    PerformanceRecorder::StartRecording for game size 2
09:04:30.07    GAME -- Starting mission...
09:04:30.75    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:04:31.25    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
09:04:32.17    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:04:54.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
09:04:54.03    PeerID 2 is CONNECTED and has 335 message receipts and 7 messages pending receipt, highwater out of sequence is 6, avg compression is 8 percent, avg packet size is 72
09:05:15.06    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
09:05:16.23    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:05:25.00    Transport::Update median kBPS [highest/current] sent = 1/0, recvd = 1/0, total = 2/1, max unsent 0, version mismatches 0 and blocked 0
09:05:55.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
09:05:55.01    PeerID 2 is CONNECTED and has 949 message receipts and 3 messages pending receipt, highwater out of sequence is 6, avg compression is 15 percent, avg packet size is 51
09:05:55.82    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:06:16.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
09:06:19.89    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:06:25.70    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:06:26.01    Transport::Update median kBPS [highest/current] sent = 1/0, recvd = 1/1, total = 2/2, max unsent 0, version mismatches 0 and blocked 0
09:06:42.78    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:06:55.70    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:06:56.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
09:06:56.01    PeerID 2 is CONNECTED and has 1565 message receipts and 2 messages pending receipt, highwater out of sequence is 6, avg compression is 19 percent, avg packet size is 63
09:07:16.59    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:07: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
09:07:20.95    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:07:21.98    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:07:27.00    Transport::Update median kBPS [highest/current] sent = 2/0, recvd = 2/1, total = 4/2, max unsent 0, version mismatches 0 and blocked 0
09:07:48.71    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:07:57.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
09:07:57.00    PeerID 2 is CONNECTED and has 2174 message receipts and 3 messages pending receipt, highwater out of sequence is 6, avg compression is 20 percent, avg packet size is 36
09:08:01.09    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:08:01.60    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
09:08:02.53    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [8] frames.
09:08:03.64    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:08:04.15    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
09:08:05.07    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [8] frames.
09:08:06.81    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [16] frames.
09:08:07.45    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:08:08.00    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
09:08:08.93    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [8] frames.
09:08:11.43    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:08:18.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
09:08:28.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/1, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
09:08:58.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
09:08:58.01    PeerID 2 is CONNECTED and has 2706 message receipts and 2 messages pending receipt, highwater out of sequence is 6, avg compression is 9 percent, avg packet size is 86
09:09:19.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
09:09:29.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/1, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
09:09:54.48    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:09:59.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
09:09:59.04    PeerID 2 is CONNECTED and has 3290 message receipts and 3 messages pending receipt, highwater out of sequence is 6, avg compression is 14 percent, avg packet size is 59
09:10:11.76    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:10:20.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
09:10:27.89    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:10:30.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/1, total = 6/2, max unsent 0, version mismatches 0 and blocked 0
09:10:33.12    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:10:54.17    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:11:00.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
09:11:00.00    PeerID 2 is CONNECTED and has 3904 message receipts and 3 messages pending receipt, highwater out of sequence is 6, avg compression is 18 percent, avg packet size is 46
09:11:02.04    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:11:18.73    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:11:21.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
09:11:31.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/1, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
09:11:45.98    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:12:01.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
09:12:01.00    PeerID 2 is CONNECTED and has 4505 message receipts and 3 messages pending receipt, highwater out of sequence is 9, avg compression is 8 percent, avg packet size is 77
09:12:22.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
09:12:32.03    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/0, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
09:13:02.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
09:13:02.00    PeerID 2 is CONNECTED and has 5080 message receipts and 3 messages pending receipt, highwater out of sequence is 9, avg compression is 5 percent, avg packet size is 87
09:13:06.28    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:13:23.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
09:13:31.28    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:13:33.03    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/1, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
09:13:57.46    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:14:03.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
09:14:03.00    PeerID 2 is CONNECTED and has 5693 message receipts and 3 messages pending receipt, highwater out of sequence is 9, avg compression is 20 percent, avg packet size is 37
09:14:07.68    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:14:15.65    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:14:19.60    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:14:20.09    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
09:14:21.04    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [8] frames.
09:14:24.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
09:14:34.01    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/1, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
09:14:34.56    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:14:38.65    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:14:39.17    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [4] frames.
09:15:04.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
09:15:04.00    PeerID 2 is CONNECTED and has 6299 message receipts and 2 messages pending receipt, highwater out of sequence is 25, avg compression is 19 percent, avg packet size is 31
09:15:06.20    P2PNetworkSynchronization::GetSyncCommand - warning, no sync command from  station [2], current lag complaint threshold = [2] frames.
09:15:25.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
09:15:35.00    Transport::Update median kBPS [highest/current] sent = 3/0, recvd = 2/1, total = 6/1, max unsent 0, version mismatches 0 and blocked 0
09:15:57.82    P2PNetworkSynchronization::PerformSyncChecking - info, sync error detected,  station 2, at frame 6651l, good station id 1.
09:15:57.82    Network - Requested CRC Block dump for frames [6651] and [6650]
09:15:57.82    SIM -- Dumping SyncErrorlog for frame 6650
09:15:57.84    SIM -- Dumping SyncErrorlog for frame 6651
09:15:57.84    GAME -- Frame 6662 - SimKillPlayer - Destroying SimPlayer 1001
09:15:57.84    
09:15:57.84    GAME -- Frame 6651 (current 6662) - We are out of sync
09:15:57.84    Network - Requested CRC Block dump for frames [6651] and [6650]
09:15:57.84    SIM -- Dumping SyncErrorlog for frame 6650
09:15:57.85    SIM -- Dumping SyncErrorlog for frame 6651
09:15:57.87    ReportMatchStats - SimID:1000, raceID:4, teamID:0, uid:589824:44461783, result:5:PS_WON
09:15:57.87    CreateSessionStats for userID 2533274834857687 on teamID 0
09:15:57.87    LiveReportStats reporting 6 views for userID 2533274834857687
09:15:57.87    ReportMatchStats - SimID:1001, raceID:0, teamID:1, uid:589824:37002817, result:3:PS_KILLED
09:15:57.87    CreateSessionStats for userID 2533274827398721 on teamID 1
09:15:57.87    LiveReportStats reporting 6 views for userID 2533274827398721
09:15:57.87    ReportMatchStats - forcing arbitration for match [
09:15:57.87    ReportSimStats - storing simulation results for match 0:63774117
09:15:57.87    ModWorld::ReportSimStats - warning, [ability\pvp\race_marine\sm_hero_xp_modifier] does not have localized name.
09:15:57.87    ModWorld::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_hq_reinforce] does not have localized name.
09:15:57.87    ModWorld::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_ripper_aura] does not have localized name.
09:15:57.87    ModWorld::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_termagaunt_aura] does not have localized name.
09:15:57.89    ModWorld::ReportSimStats - warning, [ability\pvp\race_tyranid\tyr_spawning_pool_reinforce] does not have localized name.
09:15:57.89    ModWorld::ReportSimStats - warning, [ability\pvp\race_marine\sm_hero_xp_modifier] does not have localized name.
09:15:57.92    LiveReportStats completed fine
09:15:57.92    LiveReportStats completed fine
09:15:57.92    ShandaPostStatsAsync::Initialization - Stats Upload Schema[Name:DOW2][Version:1][crc:3733708499][len:4639] Record[len:20870]
09:15:57.98    HttpRequestAsync::Initialization - sending 0 bytes to dow2stats.relic.com///reports/get_schema_id.php?name=DOW2&version=1&crc=3733708499
09:15:58.67    LiveReportResults fine
09:15:59.15    ShandaPostStatsAsync::WaitForGetSchema - schema is id 36
09:15:59.25    HttpRequestAsync::Initialization - sending 20870 bytes to dow2stats.relic.com///reports/post_report.php?schemaID=36
09:16:05.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
09:16:05.00    PeerID 2 is CONNECTED and has 6820 message receipts and 0 messages pending receipt, highwater out of sequence is 25, avg compression is 3 percent, avg packet size is 88
09:16:12.84    WorldViewSM::ProcessWVEvents - setting pause to 1
09:16:20.17    ReportStats - already reported or no need to report for match [
09:16:20.20    APP - Network quit
09:16:20.20    GameApp::TransitionNetworkQuit
09:16:20.20    MechaMeesh is now unmuted
09:16:20.20    Calling disconnect...
09:16:20.21    Session is marking PeerID 2 for death
09:16:20.21    Session is marking the local peer PeerID 1 for death
09:16:20.21    Closed connection for PeerID 2 at live://192.168.1.2,78.32.72.211?port=524?mac=ADvxBJ6A?abOnline=Cv4rAQBRD0JcPRIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:16:20.21    AdvertisementInternal::Process - EVENT_DESTROYPEER
09:16:20.21    GameObjController - OnMatchEvent: event type 1
09:16:20.21    GameObj::OnRemoteStationDisconnected - info, remote station [2] was disconnected, disconnect reason code given [2], AI simulated players will migrate to [1].
09:16:20.21    GameObj::OnRemoteStationDisconnected - info, remote station [2] is disconnected, disconnection reason code [2].
09:16:20.21    P2PNetworkSynchronization::OnDestroyedPeerEvent - info, drop event received for remote station [2].
09:16:20.21    OnDestroyedPeerEvent - calling RemovePeerFromSync.
09:16:20.21    P2PNetworkSynchronization::StartConsolidation - info, starting consolidation for station, station id= [2].
09:16:20.21    P2PNetworkSynchronization::Vote - info, voting for consolidation, station id = [2], frame = [6674]
09:16:20.21    Session::SendData local peer is marked for death, not sending
09:16:20.21    P2PNetworkSynchronization::CheckConsolidation - info, consolidation for station [2] completed.
09:16:20.21    Closed connection for PeerID 1 at live://80.129.121.10,80.129.121.10?port=524?mac=APHqn97g?abOnline=Cv42AQC9HVYyNxIAAAAA+wIAAAA=?XnKid=gAR4g2vfAJI=?XnKey=az1rMLnvSuaqSj7mS3TX+g==
09:16:20.21    AdvertisementInternal::Process - EVENT_DESTROYPEER
09:16:20.21    GameObjController - OnMatchEvent: event type 1
09:16:20.21    P2PNetworkSynchronization::OnDestroyedPeerEvent - info, drop event received for local station [1].
09:16:20.21    LeaveMatchInternal - no action taken, needLeave=0, service=0
09:16:20.21    Destroyed Matchinfo
09:16:20.21    GameApp::TransitionQuitCommon
09:16:20.21    Unable to mute opposing team, could not get the MatchInfo
09:16:20.21    PerformanceRecorder: Updating profile history
09:16:20.21    GetMaxFrameTimeFromProfile: players=2 expected FPS=5.863127, bars=1, max avg=0.146, sd=0.025, 4 samples =  0.11 0.14 0.15 0.18
09:16:20.21    PerformanceRecorder::EndRecording - game size=2, max average=0.113085, worst frame=0.170557
09:16:20.21     Recording: No [2 players]

09:16:20.21     Total frame time: 9.07 sec

09:16:20.21     Total frame count: 224

09:16:20.21     Max/Avg: 0.11, 0.06 sec (fps=8.84, 16.51) (34 samples)

09:16:20.21     Bars: 1

09:16:20.21    Profile Max Performance[2 players] =  0.11 0.14 0.15 0.18 0.00
09:16:20.21    Profile Avg Performance[2 players] =  0.06 0.10 0.10 0.12 0.00
09:16:20.21    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [468MB] Used [255MB].
09:16:20.53    VIDEO -- Texture Memory Before Shrink Memory: Video  [512MB] Total [723MB] Available [664MB] Used [59MB].
09:16:20.54    GameObj::ShutdownGameObj
09:16:20.54    GAME -- Ending mission - 'Game over'
09:16:20.76    MessageInternal::DestroyChannel: Destroyed channel MODM
09:16:20.96    SOUND -- Flushing cache ...
09:16:21.00    SOUND -- Flush complete!
09:16:21.00    SOUND: Inv::Inventory::Flush... Start!
09:16:21.06    SOUND: Inv::Inventory::Flush... Done!
