-- Log file for all dbTracef messages --

23:06:19.88   NetworkManager::Create - creating network manager
23:06:19.88   Read 567 bytes from network datastore login_cache.bin
23:06:19.90   Read 109962 bytes from network datastore global_cache.bin
23:06:19.90   Read 8002 bytes from network datastore ping_cache.bin
23:06:19.90   QuazalInitializer - static initializing Quazal library
23:06:19.90   PingCache - populating cache with 443 pings
23:06:19.99   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
23:06:20.02   WinTransport - CreateSocket exclusive broadcast socket was available.
23:06:20.02   WinTransport - CreateSocket listening for broadcasts on default port
23:06:20.03   WinTransport - Host Name: Alex-PC, aliases: , type=AF_INET, len=4
23:06:20.03   WinTransport - Host IP Address #0: 192.168.0.199
23:06:20.03   WinTransport - Interface #0: ip:192.168.0.199, broadcast:192.168.0.199, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
23:06:20.03   WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
23:06:20.03   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:06:20.03   WinTransport - Quazal address string = udp:/address=192.168.0.199;port=6112
23:06:20.03   SessionManager - Peer Header Size = 16 bytes
23:06:20.03   SessionManager - Game Data overhead = 7 bytes
23:06:20.03   SessionManager - Proxy overhead = 7 bytes
23:06:20.03   MessageInternal::CreateChannel: Created channel 47535450
23:06:20.03   Session::Initialize - info, initializing session object, using threads.
23:06:20.03   SessionManager::RegisterSession - Registering new session 10e3d618
23:06:20.03   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:06:20.03   AutomatchInternal: Instantiating
23:06:20.03   PartyInternal: Instantiating
23:06:20.03   MessageInternal::CreateChannel: Created channel 50525459
23:06:20.03   MessageInternal::CreateChannel: Created channel 51434b4d
23:06:20.03   Net::ThreadFunction - Entering network thread function...
23:06:20.05   Transport - Largest received is now 19
23:06:20.05   Transport::OpenInternal request to WINaddr:192.168.0.199:6112;
23:06:20.07   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
23:06:20.07   MessageInternal::CreateChannel: Created channel 534d5347
23:06:20.07   MessageInternal::CreateChannel: Created channel 474d4343
23:06:20.07   MessageInternal::CreateChannel: Created channel 474f424a
23:06:20.07   MessageInternal::CreateChannel: Created channel 4d4f444d
23:06:20.07   MessageInternal::CreateChannel: Created channel 53594e43
23:06:20.07   MessageInternal::DestroyChannel: Destroyed channel 534d5347
23:06:20.07   MessageInternal::DestroyChannel: Destroyed channel 474d4343
23:06:20.07   MessageInternal::DestroyChannel: Destroyed channel 474f424a
23:06:20.07   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
23:06:20.07   MessageInternal::DestroyChannel: Destroyed channel 53594e43
23:06:20.08   GAME -- Available memory: 3325MB Physical RAM, 3528MB Pagefile, 2047 Virtual Address Space
23:06:24.99   DLLDriverLinker -- Adding driver 'spDx10.dll'.
23:06:25.09   DLLDriverLinker -- Adding driver 'spDx9.dll'.
23:06:25.09   DLLDriverLinker -- 2 DLL drivers found.
23:06:25.14   SPDx10 -- Adapter [NVIDIA GeForce 8800 GT ]: 497MB dedicated video memory, 0MB dedicated system memory and 1407MB shared system memory.
23:06:26.80   DLLDriverLinker -- 2 DLL drivers found.
23:06:26.97   SPOOGE - Driver[DirectX10 Rendering Device] version[4,36]
23:06:26.97   GAME -- Resolution set to 1680x1050 (fullscreen).
23:06:27.00   SPDx10 -- Adapter Description = NVIDIA GeForce 8800 GT
23:06:27.00   SPDx10 -- Driver Vendor = 0x000010de  Device = 0x00000611  SubSys = 0x080110b0  Rev = 0x000000a2
23:06:27.00   SPDx10 -- Driver Version  Product = 0x0008  Version = 0x0011  SubVersion = 0x00  Build = 196.21
23:06:27.00   SPDx10 -- Driver LUID = 0x00000000-0x0000fbdc
23:06:27.01   SPDx10 -- 497MB dedicated video memory, 0MB dedicated system memory and 1407MB shared system memory available.
23:06:27.05   ShaderDatabase: using shader profile [ps40]
23:06:29.05   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
23:06:29.27   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
23:06:29.33   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
23:06:30.32   GameObjLoader 02761368 - resetting counters
23:06:30.32   GameObjLoader 02761368 - Created loader
23:06:30.32   GameObjLoader 027614c8 - resetting counters
23:06:30.32   GameObjLoader 027614c8 - Created loader
23:06:31.07   GAME -- Beginning FE
23:06:31.07   Sent message game CompanyOfHeroes started 5224 601 allowtraffic
23:06:31.07   RemoteDLManager - Connection Restored.
23:06:31.07   UIFrontEnd - Loading Front End
23:06:31.07   THREAD: Hyper-Threading Technology Processors are not detected.
23:06:31.30   SOUND -- Initializing ...
23:06:31.40   INNIMapDCA Key not found: sp_speechducker::time
23:06:32.30   SOUND -- Initialization completed!
23:06:32.30   UIFrontEnd - Initializing Forms
23:06:34.67   CampaignFilter::BindFilterSpecificWidgets()
23:06:34.77   Activating screen: AppLoadingForm
23:06:34.77   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:06:34.77   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
23:06:37.52   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
23:06:37.52   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
23:06:37.52   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
23:06:37.54   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
23:06:37.56   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
23:06:37.56   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
23:06:38.01   GAME -- Using player profile ALEX-PC
23:06:39.34   Dx10Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
23:06:40.07   Dx10Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
23:06:43.19   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
23:06:43.19   RendezvousManager: CreateSession - starting profile=Guest login
23:06:44.37   RendezvousManager: Login complete and successfull
23:06:44.37   RendezvousManager initialized
23:06:44.48   Current server English:live version is 601.0, client is 601.0
23:06:44.49   OnConnect: successful connection established, enabling reconnect
23:06:44.49   OnConnect: this wasnt a reconnect, no need for autologin
23:06:44.49   Logging in xB1aSTeRx on controller:0
23:06:44.83   Login completed: ACCOUNT_VALIDATED
23:06:44.83   Found 1 profiles for account xB1aSTeRx
23:06:44.83   Found profile: xB1aSTeRx
23:06:44.83   installed_products = ( DLC1 DLC2 DLC3 CXP1 COH )
23:06:44.83   OnLogin: no previous login, auto selecting profile not required
23:06:44.83   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:06:44.83   CRC & Version Info : 00000259:6aa29d62:48d2c5df eastern_front:601:ww2mod.dll 1
23:06:44.87   Activating screen: FEMovie
23:06:44.87   Activating screen: OnlineWidget
23:06:44.87   Activating screen: RelicOnlineProfileSelect
23:06:45.00   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:06:45.00   Activating screen: RelicOnlineWait
23:06:45.00   RendezvousManager - destroying chat handler
23:06:45.00   RendezvousManager: CreateSession - starting logout profile = 100:Guest
23:06:45.19   RendezvousManager: Logout complete
23:06:45.19   RendezvousManager - terminating all server calls in progress
23:06:45.19   CallManager - terminating all server calls in progress (1 in progress)
23:06:45.19   RendezvousManager: OnCredentialsEvent - starting profile login
23:06:46.28   RendezvousManager: Login complete and successfull
23:06:46.28   RendezvousManager - creating chat handler
23:06:46.29   RendezvousManager::CreateNATTraversalClient - NAT traversal available.
23:06:46.44   QuazalSelectProfileAsync - Got UserID
23:06:46.45   Transport - Largest sent is now 16
23:06:46.58   Transport - Largest received is now 42
23:06:46.58   GetUserStats requested stats for PIDs ( 3052293 ) (best:0, full:1)
23:06:46.71   SelectProfileAsync - RegisterLocalURLs public [udp:/address=90.231.136.27;port=6112;PID=3052293;RVCID=87878512], private [udp:/address=192.168.0.199;port=6112;PID=3052293]
23:06:46.84   QuazalSelectProfileAsync - Got Full Stats
23:06:46.99   GetAutomatchMaps: Got [32] maps
23:06:47.00   PopulateArmyListBox - skipping race 2
23:06:47.00   PopulateArmyListBox - skipping race 0
23:06:47.00   PopulateArmyListBox - skipping race 1
23:06:47.00   PopulateArmyListBox - skipping race 3
23:06:47.00   AutoMatchForm::OnArmySelectionChanged - sending request info
23:06:47.00   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
23:06:47.00   AutoMatchForm::OnMatchTypeSelectionChanged - sending team info
23:06:47.01   QuazalSelectProfileAsync - Got Automatch maps
23:06:47.89   QuazalSelectProfileAsync - GetFriends result - CacheState = 1
23:06:48.03   Profile [00000000:002e9305] selected on controller#0
23:06:48.03   Activating screen: FEMovie
23:06:48.03   Activating screen: OnlineWidget
23:06:48.03   Activating screen: FE_mm_01
23:06:48.03   Activating screen: RelicOnlineWait
23:06:48.03   GAME -- Setting campaign state to 'coh'
23:06:48.03   GAME -- Closing state 'coh'
23:06:48.05   GAME -- Setting campaign state to 'cxp2'
23:06:48.05   GAME -- Closing state 'cxp2'
23:06:48.06   GAME -- Setting campaign state to 'cxp1'
23:06:48.06   GAME -- Closing state 'cxp1'
23:06:48.06   GAME -- Setting campaign state to 'dlc1'
23:06:48.06   GAME -- Closing state 'dlc1'
23:06:48.07   GAME -- Setting campaign state to 'dlc2'
23:06:48.07   GAME -- Closing state 'dlc2'
23:06:48.07   GAME -- Setting campaign state to 'dlc3'
23:06:48.07   GAME -- Closing state 'dlc3'
23:07:00.69   Activating screen: MessageBoxPopup
23:07:00.69   Created Matchinfo
23:07:00.69   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
23:07:00.69   starting online hosting
23:07:00.70   OnlineHostAsync: initiating CallCreateMatch
23:07:00.83   OnlineHostAsync: created gid=152167086
23:07:00.84   Transport - Largest sent is now 79
23:07:00.93   RendezvousNotifier - Received Participate ParticipationEvent.
23:07:00.98   Transport - Largest received is now 105
23:07:01.10   OnlineHostAsync - RegisterLocalURLs public [udp:/address=90.231.136.27;port=6112;PID=3052293;RVCID=87878512], private [udp:/address=192.168.0.199;port=6112;PID=3052293]
23:07:01.24   OnlineHostAsync: initiating UpdateSessionURL [gid=152167086, url=udp:/address=90.231.136.27;port=6112;PID=3052293;RVCID=87878512]
23:07:01.40   OnJoinAdvertisementSuccess - joined online match, server leave notification required
23:07:01.40   starting local hosting
23:07:01.40   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:07:01.40   Allocated route ID=0 for PeerID 1 at WINaddr:192.168.0.199:6112;
23:07:01.40   Transport::OpenInternal request to WINaddr:192.168.0.199:6112;
23:07:01.40   Session::Host sid = 911E2AE, hostURL = , local addresses = WINaddr:192.168.0.199:6112;
23:07:01.40   ValidateCustomData: called with 463 bytes of custom data
23:07:01.40   Host accepted Peer 1 into the match at address list=WINaddr:192.168.0.199:6112;, routes=WINaddr:192.168.0.199:6112;
23:07:01.40   AdvertisementInternal::Process - EVENT_NEWPEER
23:07:01.40   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
23:07:01.40   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
23:07:01.40   hosting - Session is connected
23:07:01.40   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:01.41   hosting completed successfully
23:07:01.41   HostAsync - completed with HostResult = 0
23:07:01.41   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
23:07:01.41   Activating screen: OnlineGameSetup
23:07:01.41   MessageInternal::CreateChannel: Created channel 534d5347
23:07:01.41   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:01.41   MatchInternal::SetMatchType - new type 14 - updating server
23:07:01.42   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:07:01.42   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:07:01.49   SetVisible called while !IsConnected
23:07:01.49   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:01.50   Activating screen: RelicOnlineChat
23:07:01.50   Activating screen: RelicOnlineNewsScreen
23:07:01.55   Activating screen: RelicOnlineStatsScreen
23:07:01.55   Activating screen: Achievements
23:07:01.56   GAME -- Setting campaign state to 'coh'
23:07:01.56   GAME -- Closing state 'coh'
23:07:01.56   GAME -- Setting campaign state to 'cxp2'
23:07:01.56   GAME -- Closing state 'cxp2'
23:07:01.57   GAME -- Setting campaign state to 'cxp1'
23:07:01.57   GAME -- Closing state 'cxp1'
23:07:01.57   GAME -- Setting campaign state to 'dlc1'
23:07:01.57   GAME -- Closing state 'dlc1'
23:07:01.58   GAME -- Setting campaign state to 'dlc2'
23:07:01.58   GAME -- Closing state 'dlc2'
23:07:01.58   GAME -- Setting campaign state to 'dlc3'
23:07:01.58   GAME -- Closing state 'dlc3'
23:07:01.59   GAME -- Setting campaign state to 'dlc1'
23:07:01.59   GAME -- Closing state 'dlc1'
23:07:01.60   Activating screen: GameHistory
23:07:01.60   GAME -- Setting campaign state to 'coh'
23:07:01.60   GAME -- Closing state 'coh'
23:07:01.61   GAME -- Setting campaign state to 'cxp2'
23:07:01.61   GAME -- Closing state 'cxp2'
23:07:01.61   GAME -- Setting campaign state to 'cxp1'
23:07:01.61   GAME -- Closing state 'cxp1'
23:07:01.62   GAME -- Setting campaign state to 'dlc1'
23:07:01.62   GAME -- Closing state 'dlc1'
23:07:01.62   GAME -- Setting campaign state to 'dlc2'
23:07:01.62   GAME -- Closing state 'dlc2'
23:07:01.63   GAME -- Setting campaign state to 'dlc3'
23:07:01.63   GAME -- Closing state 'dlc3'
23:07:01.63   Activating screen: OnlineGameSetup
23:07:01.63   Activating screen: RelicOnlineTabs
23:07:01.63   AutomatchInternal::OnHostComplete - Completed Host with success=1
23:07:01.63   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
23:07:01.63   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
23:07:01.64   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:01.64   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:01.64   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:01.78   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:01.79   GAME -- Setting campaign state to 'coh'
23:07:01.79   GAME -- Closing state 'coh'
23:07:01.80   GAME -- Setting campaign state to 'cxp2'
23:07:01.80   GAME -- Closing state 'cxp2'
23:07:01.80   GAME -- Setting campaign state to 'cxp1'
23:07:01.80   GAME -- Closing state 'cxp1'
23:07:01.81   GAME -- Setting campaign state to 'dlc1'
23:07:01.81   GAME -- Closing state 'dlc1'
23:07:01.81   GAME -- Setting campaign state to 'dlc2'
23:07:01.81   GAME -- Closing state 'dlc2'
23:07:01.82   GAME -- Setting campaign state to 'dlc3'
23:07:01.82   GAME -- Closing state 'dlc3'
23:07:01.83   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
23:07:01.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:02.65   Requesting Relic Downloader soft throttle call [GetNewsAsync] has time 823
23:07:02.65   Sent message game CompanyOfHeroes softthrottle
23:07:02.67   Got dlman msg [ack game CompanyOfHeroes softthrottle]
23:07:03.11   Activating screen: DynamicPopupMenu
23:07:03.36   GetUserStats requested stats for PIDs ( 3055263 3060096 ) (best:2, full:0)
23:07:03.36   QueryMatches: Got [36] maps, [102] ids, [17] advertisements, startID [1]
23:07:03.36   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 85 matches
23:07:04.57   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:04.57   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:04.57   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:04.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:04.60   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
23:07:04.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:05.62   Activating screen: RelicOnlineNewsScreen
23:07:05.62   Activating screen: RelicOnlineTabs
23:07:05.62   Activating screen: ScreenTipPopup
23:07:06.56   QueryMatches: Got [37] maps, [101] ids, [17] advertisements, startID [152165735]
23:07:06.57   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 67 matches
23:07:09.15   Activating screen: OnlineGameSetup
23:07:09.15   Activating screen: RelicOnlineTabs
23:07:11.55   QueryMatches: Got [36] maps, [102] ids, [17] advertisements, startID [152166451]
23:07:11.56   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 51 matches
23:07:14.13   Activating screen: RaceSelectionPopup
23:07:15.00   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:15.00   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:15.00   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:15.00   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:15.02   UpdateMatch: Call to UpdateGathering started, matchTypeID = 14.
23:07:15.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:16.44   QueryMatches: Got [36] maps, [100] ids, [17] advertisements, startID [152166703]
23:07:16.44   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 32 matches
23:07:18.20   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:18.20   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:18.20   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:18.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:18.31   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:20.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 0.1/0.0, #p/sec[s/r] = 0.0/0.2, max unsent 0, version err 0, merge 0
23:07:21.43   QueryMatches: Got [37] maps, [100] ids, [17] advertisements, startID [152166936]
23:07:21.43   QuazalGetAdvertisementsAsync: Queuing refresh to obtain unknown 16 matches
23:07:23.31   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:23.31   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:23.31   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:23.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:23.35   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:24.60   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:24.60   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:24.60   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:24.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:24.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:24.71   Transport - Largest sent is now 80
23:07:26.44   QueryMatches: Got [38] maps, [98] ids, [17] advertisements, startID [152167040]
23:07:30.04   Activating screen: RaceSelectionPopup
23:07:30.98   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:30.98   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:30.98   GetMaxFrameTimeFromProfile: players=4 expected FPS=16.937698, bars=5, max avg=0.049, sd=0.010, 4 samples =  0.03 0.06 0.06 0.05
23:07:31.05   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:31.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:36.99   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:07:36.99   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:36.99   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:36.99   MatchInternal::SetMatchState - state 1 - updating server
23:07:36.99   Net::Session::SetVisible - session is set to INVISIBLE.
23:07:36.99   MatchSetup: Sending start game message!
23:07:36.99   GameSetupForm - Starting game
23:07:36.99   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:07:37.00   PopulateGameInfo - random seed:[1289340456], guid:[{632e5525-b73b-4b9a-94be-c9e2c9da4cfa}], sync level:[0]
23:07:37.00   Error loading [DATA:levelingCurve.lua]
23:07:37.00   Error loading [DATA:levelingCurve.lua]
23:07:37.00   Error loading [DATA:levelingCurve.lua]
23:07:37.01   Error loading [DATA:levelingCurve.lua]
23:07:37.01   MOD - Setting player (0) race to: allies_soviets
23:07:37.01   MOD - Setting player (0) race to: 2
23:07:37.01   MOD - Setting player (1) race to: allies
23:07:37.01   MOD - Setting player (1) race to: 1
23:07:37.01   MOD - Setting player (2) race to: axis
23:07:37.01   MOD - Setting player (2) race to: 3
23:07:37.01   MOD - Setting player (3) race to: axis_panzer_elite
23:07:37.01   MOD - Setting player (3) race to: 4
23:07:37.01   OnlineUpdateStateAsync: initiating state change, id = 152167086, state=2
23:07:37.03   APP -- Game Start
23:07:37.03   Sent message game CompanyOfHeroes allowtraffic
23:07:37.04   GAME -- Setting campaign state to 'coh'
23:07:37.04   GAME -- Closing state 'coh'
23:07:37.04   GAME -- Setting campaign state to 'cxp2'
23:07:37.04   GAME -- Closing state 'cxp2'
23:07:37.05   GAME -- Setting campaign state to 'cxp1'
23:07:37.05   GAME -- Closing state 'cxp1'
23:07:37.05   GAME -- Setting campaign state to 'dlc1'
23:07:37.05   GAME -- Closing state 'dlc1'
23:07:37.06   GAME -- Setting campaign state to 'dlc2'
23:07:37.06   GAME -- Closing state 'dlc2'
23:07:37.07   GAME -- Setting campaign state to 'dlc3'
23:07:37.07   GAME -- Closing state 'dlc3'
23:07:37.07   MessageInternal::DestroyChannel: Destroyed channel 534d5347
23:07:37.07   GAME -- Ending FE
23:07:37.07   UIFrontEnd - Unloading Front End
23:07:37.09   SOUND -- Shutting down ...
23:07:37.14   SOUND -- Shutdown completed!
23:07:37.16
23:07:37.16   GAME -- *** Beginning mission 4p_linden (1 Humans, 3 Computers) ***
23:07:37.16
23:07:37.42   GAME -- Recording game
23:07:37.49   Activating screen: GameLoadScreen
23:07:37.50   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
23:07:37.72   OnlineUpdateStateAsync: updated state for gid=152167086
23:07:37.90   QuazalPostStatsAsync: Simulation results sent to server for gid=0
23:07:37.94   THREAD: Hyper-Threading Technology Processors are not detected.
23:07:38.00   SOUND -- Initializing ...
23:07:38.98   SOUND -- Initialization completed!
23:07:39.04   PHYSICS: detected processor(s) capable of handling 2 threads.
23:07:39.12   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\classic\4p_linden\4p_linden'
23:07:39.12   MOD -- Using Mod 'Eastern_Front'
23:07:39.17   Unable to load/parse precache file [DATA:scenarios\mp\classic\4p_linden\4p_linden_precache.lua]
23:07:39.18   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
23:07:39.19   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
23:07:44.20   GameObjLoader - upgrading load_count from 0 to 1097
23:07:49.38   GameObjLoader - upgrading load_count from 1097 to 1797
23:07:49.54   PHYSICS -- Created node factory 'HVOK'
23:07:49.54   PHYSICS -- Created node factory 'DMMY'
23:08:02.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:08:02.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:08:14.59   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
23:08:21.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:08:24.17   GameObjLoader - upgrading load_count from 49 to 4216
23:08:35.04   GameObjLoader 02761368 - resetting counters
23:08:35.04   GameObjLoader 02761368 - LOAD_DONE
23:08:35.04   GAME - SessionSetup
23:08:35.79   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
23:08:35.79   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 2048 x 2048
23:08:35.79   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
23:08:44.41   SPDx10 -- Cannot lock non-4 texel aligned regions of DXT textures. xStart: 1600, yStart: 1098
23:08:44.41   SPDx10 -- Could not lock destination texture for copy.
23:08:44.41   SPDx10 -- Cannot lock non-4 texel aligned regions of DXT textures. xStart: 1600, yStart: 1098
23:08:44.41   SPDx10 -- Could not lock destination texture for copy.
23:08:44.41   SPDx10 -- Cannot lock non-4 texel aligned regions of DXT textures. xStart: 1600, yStart: 1098
23:08:44.41   SPDx10 -- Could not lock destination texture for copy.
23:08:44.41   SPDx10 -- Cannot lock non-4 texel aligned regions of DXT textures. xStart: 1600, yStart: 1098
23:08:44.41   SPDx10 -- Could not lock destination texture for copy.
23:08:44.41   SPDx10 -- Cannot lock non-4 texel aligned regions of DXT textures. xStart: 1600, yStart: 1098
23:08:44.41   SPDx10 -- Could not lock destination texture for copy.
23:08:46.04   GAME - CreateGEWorld in 11005 ms
23:08:46.07   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
23:08:46.89   GAME - SessionSetup finished in 11856 ms
23:08:46.91   GAME - WaterReflectionManagerSetup
23:08:46.91   GAME - WaterReflectionManagerSetup finished in 0 ms
23:08:47.88   MessageInternal::CreateChannel: Created channel 474d4343
23:08:47.93   Regenerating ImpassMap data...
23:08:47.93       Impass Data was already valid, but regenerating...
23:08:48.13   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
23:08:48.13   Regenerating CanBuildMap data...
23:08:48.13   Generating CanShoot Map.
23:08:48.13   Pathfinder::Regenerate()...
23:08:48.19   Generating PathSectorMap...
23:08:48.56   Pathfinder::Regenerate() Done.
23:08:48.82   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
23:08:48.86   Sector 26 is a single cell, it can't have its border traced
23:08:53.02   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:08:53.02   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:08:53.02   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:08:53.02   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:08:54.30   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m07_ob2_findrocketlo_load.smf'.  Expensive operation
23:08:54.87   MessageInternal::CreateChannel: Created channel 4d4f444d
23:08:55.98   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:08:55.98   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:08:55.98   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:08:55.98   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:08:55.98   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:08:56.72   SPEECHMANAGER -- Loaded in 0.692070 seconds
23:08:59.14   GameObjLoader - upgrading load_count from 0 to 422
23:09:02.17   GameObjLoader 027614c8 - resetting counters
23:09:02.17   GameObjLoader 027614c8 - LOAD_DONE
23:09:03.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:09:03.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:09:03.60   PreloadResources took 0ms.
23:09:03.71   GAME -- Loading completed (86 seconds)
23:09:03.71   SIM -- Setting SyncErrorChecking level to Low
23:09:06.76   Activating screen: GameScreen
23:09:06.76   Activating screen: Decorators_widescreen
23:09:06.76   Activating screen: Taskbar_widescreen
23:09:06.76   Activating screen: SubtitleScreen
23:09:06.76   Activating screen: TextOverlayScreen
23:09:06.86   PerformanceRecorder::StartRecording for game size 4
23:09:06.86   GAME -- Starting mission...
23:09:12.88   MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI)
23:09:12.88   MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI)
23:09:12.88   MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI)
23:09:13.32   Activating screen: Command_Tree
23:09:14.86   Activating screen: Command_Branch
23:09:17.62   Warning: non auto-match upgrade not found in AE, tuning
23:09:22.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:09:28.23   Activating screen: Command_Branch
23:09:47.90   Activating screen: NewObjective_widescreen
23:09:48.68   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:10:01.74   Activating screen: pause_menu
23:10:01.74   GAME -- SimulationController::Pause 0
23:10:03.46   Activating screen: pause_options
23:10:04.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:10:04.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:10:12.50   SPDx10 -- Gamma Caps - Scale/Offset supported: no, Max: 1.00, Min: 0.00, Number of Control Points: 256.
23:10:14.06   GAME -- SimulationController::Pause 1
23:10:23.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:10:33.07   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:10:52.96   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
23:11:05.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:11:05.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:11:24.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:12:06.02   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:12:06.02   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:12:25.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:13:07.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:13:07.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:13:26.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:14:08.02   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:14:08.02   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:14:27.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:15:09.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:15:09.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:15:28.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:16:10.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:16:10.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:16:29.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:17:11.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:17:11.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:17:30.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:18:12.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:18:12.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:18:31.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:18:36.89   Activating screen: Command_Branch
23:19:13.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:19:13.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:19:32.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:20:14.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:20:14.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:20:33.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:20:42.28   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:20:52.28   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:21:01.52   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:21:11.68   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:21:15.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:21:15.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:21:24.16   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:21:29.29   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:21:34.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:21:34.65   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:21:39.02   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:40.07   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:41.02   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:42.02   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:43.02   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:44.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:45.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:45.52   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:21:46.16   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:47.25   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:48.16   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:49.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:50.15   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:51.16   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:52.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:53.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:54.15   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:55.16   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:56.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:57.15   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:58.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:21:59.17   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:00.15   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:01.17   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:02.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:03.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:04.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:05.29   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:06.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:07.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:08.29   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:09.31   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:10.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:11.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:12.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:13.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:14.40   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:15.40   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:16.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:22:16.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:22:16.41   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:17.41   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:18.39   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:19.51   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:20.52   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:21.15   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:22.16   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:23.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:24.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:25.15   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:26.14   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:27.16   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:28.15   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:29.17   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:30.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:31.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:32.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:33.26   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:34.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:35.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:22:35.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:36.29   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:37.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:38.30   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:39.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:40.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:41.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:42.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:43.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:44.29   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:45.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:46.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:47.28   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:48.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:49.30   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:50.26   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:51.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:52.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:53.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:54.29   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:55.31   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:56.26   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:57.27   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:58.39   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:22:59.42   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:00.39   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:01.41   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:02.40   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:03.39   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:04.40   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:05.42   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:06.40   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:07.40   An ability failed to cast because target validation failed: abilities\axis_pe_air_dropped_mines
23:23:09.54   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:23:17.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:23:17.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:23:20.81   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:23:20.81   Muting spew of bind updater.  Fix art and re-test.
23:23:36.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:24:18.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:24:18.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:24:37.00   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:25:19.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:25:19.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:25:35.26   Activating screen: Command_Branch
23:25:38.02   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:25:49.16   Unabled to do upgrade, CANPRODUCE_NoResources
23:25:50.15   Unabled to do upgrade, CANPRODUCE_NoResources
23:26:20.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:26:20.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:26:38.96   Activating screen: Command_Branch
23:26:39.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:27:21.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:27:21.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
23:27:40.01   Transport - median kBPS [hi/cur] sent = 0.2/0.0, recvd = 0.2/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
23:27:54.08   Unabled to do upgrade, CANPRODUCE_NoResources
23:28:22.00   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:192.168.0.199:6112; (ping=0ms) 100.00%, pending=0, dead=0
23:28:22.00   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=0/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
