-- Log file for all dbTracef messages --

22:20:53.75   NetworkManager::Create - creating network manager
22:20:53.76   Read 269 bytes from network datastore login_cache.bin
22:20:53.76   Read 52 bytes from network datastore global_cache.bin
22:20:53.76   Read 28 bytes from network datastore ping_cache.bin
22:20:53.76   QuazalInitializer - static initializing Quazal library
22:20:53.76   PingCache - populating cache with 0 pings
22:20:53.86   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
22:20:53.91   WinTransport - CreateSocket exclusive broadcast socket was available.
22:20:53.91   WinTransport - CreateSocket listening for broadcasts on default port
22:20:53.92   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
22:20:53.92   WinTransport - Host IP Address #0: 5.3.208.164
22:20:53.92   WinTransport - WARNING, MultipleNetwork adapters may cause problems
22:20:53.92   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
22:20:53.92   WinTransport - Interface #1: ip:192.168.1.101, broadcast:192.168.1.101, flags=IFF_BROADCAST IFF_MULTICAST
22:20:53.92   WinTransport - Interface #2: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
22:20:53.92   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
22:20:53.92   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
22:20:53.92   SessionManager - Peer Header Size = 16 bytes
22:20:53.92   SessionManager - Game Data overhead = 7 bytes
22:20:53.92   SessionManager - Proxy overhead = 7 bytes
22:20:53.92   MessageInternal::CreateChannel: Created channel 47535450
22:20:53.92   Session::Initialize - info, initializing session object, using threads.
22:20:53.92   SessionManager::RegisterSession - Registering new session 0f9a2e40
22:20:53.92   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
22:20:53.92   AutomatchInternal: Instantiating
22:20:53.92   PartyInternal: Instantiating
22:20:53.92   MessageInternal::CreateChannel: Created channel 50525459
22:20:53.92   MessageInternal::CreateChannel: Created channel 51434b4d
22:20:53.92   Net::ThreadFunction - Entering network thread function...
22:20:53.92   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
22:20:53.92   MessageInternal::CreateChannel: Created channel 534d5347
22:20:53.92   MessageInternal::CreateChannel: Created channel 474d4343
22:20:53.92   MessageInternal::CreateChannel: Created channel 474f424a
22:20:53.92   MessageInternal::CreateChannel: Created channel 4d4f444d
22:20:53.92   MessageInternal::CreateChannel: Created channel 53594e43
22:20:53.92   MessageInternal::DestroyChannel: Destroyed channel 534d5347
22:20:53.92   MessageInternal::DestroyChannel: Destroyed channel 474d4343
22:20:53.92   MessageInternal::DestroyChannel: Destroyed channel 474f424a
22:20:53.92   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
22:20:53.92   MessageInternal::DestroyChannel: Destroyed channel 53594e43
22:20:53.92   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
22:20:53.94   Transport - Largest received is now 19
22:20:53.94   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
22:20:53.95   Transport - Largest sent is now 19
22:20:57.19   DLLDriverLinker -- Adding driver 'spDx10.dll'.
22:20:57.20   DLLDriverLinker -- Adding driver 'spDx9.dll'.
22:20:57.20   DLLDriverLinker -- 2 DLL drivers found.
22:20:57.26   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
22:20:58.91   DLLDriverLinker -- 2 DLL drivers found.
22:20:59.31   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
22:20:59.31   GAME -- Resolution set to 1024x768 (fullscreen).
22:20:59.35   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
22:20:59.35   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
22:20:59.35   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
22:20:59.35   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
22:20:59.89   SPDx9 -- 1774MB available Texture Memory
22:20:59.89   ShaderDatabase: using shader profile [ps30]
22:21:00.45   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
22:21:01.49   GameObjLoader 092b5c38 - resetting counters
22:21:01.49   GameObjLoader 092b5c38 - Created loader
22:21:01.49   GameObjLoader 092b5d98 - resetting counters
22:21:01.49   GameObjLoader 092b5d98 - Created loader
22:21:11.09   GAME -- Beginning FE
22:21:11.09   Sent message game CompanyOfHeroes started 4252 602 allowtraffic
22:21:11.10   RemoteDLManager - Connection Restored.
22:21:11.10   UIFrontEnd - Loading Front End
22:21:11.10   THREAD: Hyper-Threading Technology Processors are not detected.
22:21:11.20   SOUND -- Initializing ...
22:21:11.31   INNIMapDCA Key not found: sp_speechducker::time
22:21:11.90   SOUND -- Initialization completed!
22:21:11.90   UIFrontEnd - Initializing Forms
22:21:13.69   CampaignFilter::BindFilterSpecificWidgets()
22:21:13.78   Activating screen: AppLoadingForm
22:21:13.78   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:21:13.78   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
22:21:15.94   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
22:21:15.94   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
22:21:15.94   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
22:21:15.95   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
22:21:15.95   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
22:21:15.95   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
22:21:16.61   GAME -- Using player profile NGOCQUANG-PC
22:21:18.02   Transport::OpenInternal request to WINaddr:192.168.1.100:6112;
22:21:20.39   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
22:21:21.35   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
22:21:25.57   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
22:21:25.57   RendezvousManager: CreateSession - starting profile=Guest login
22:21:37.67   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
22:21:37.67   RendezvousManager - unable to connect to the server as guest
22:21:37.72   OnConnect: connect failure
22:21:37.72   RendezvousManager::Shutdown - deleting instance
22:21:37.72   RendezvousManager - terminating all server calls in progress
22:21:37.72   CallManager - terminating all server calls in progress (1 in progress)
22:21:37.72   RendezvousManager - destroying chat handler
22:21:37.72   ~RendezvousManager - m_state = 7, no need for server disconnect
22:21:37.74   OnConnect: this wasnt a reconnect, no need for autologin
22:21:37.84   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
22:21:37.84   Activating screen: FEMovie
22:21:37.84   Activating screen: OnlineWidget
22:21:37.84   Activating screen: RelicOnlineLogin
22:21:37.84   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:21:37.96   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:21:37.96   You have a valid version of the game.
22:21:37.97   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
22:21:37.97   installed_products = ( DLC1 DLC2 DLC3 )
22:21:37.97   OnLogin: no previous login, auto selecting profile not required
22:21:37.97   Activating screen: MessageBoxPopup
22:21:37.97   Activating screen: MessageBoxPopup
22:21:37.97   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
22:21:43.38   SPDx9 -- 1773MB available Texture Memory
22:21:54.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 0.1/0.0, #p/sec[s/r] = 0.4/0.6, max unsent 0, version err 0, merge 0
22:22:10.97   SPDx9 -- 1773MB available Texture Memory
22:22:13.02   Beginning media verification...
22:22:13.02   Validator type : validators\udro\udro.dll
22:22:13.02   Activating screen: MessageBoxPopup
22:22:16.25   Activating screen: FE_mm_01
22:22:16.25   GAME -- Setting campaign state to 'dlc1'
22:22:16.25   GAME -- Closing state 'dlc1'
22:22:16.26   GAME -- Setting campaign state to 'dlc2'
22:22:16.26   GAME -- Closing state 'dlc2'
22:22:16.26   GAME -- Setting campaign state to 'dlc3'
22:22:16.26   GAME -- Closing state 'dlc3'
22:22:34.83   SPDx9 -- 1773MB available Texture Memory
22:22:39.48   Activating screen: MessageBoxPopup
22:22:39.48   Created Matchinfo
22:22:39.48   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
22:22:39.48   starting LAN hosting
22:22:39.51   OnJoinAdvertisementSuccess - joined online match, server leave notification required
22:22:39.51   starting local hosting
22:22:39.51   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
22:22:39.51   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
22:22:39.51   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
22:22:39.51   Session::Host sid = A1AA3BF69DBB6602, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
22:22:39.51   ValidateCustomData: called with 217 bytes of custom data
22:22:39.51   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
22:22:39.51   AdvertisementInternal::Process - EVENT_NEWPEER
22:22:39.51   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
22:22:39.53   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
22:22:39.53   hosting - Session is connected
22:22:39.53   Net::Session::SetVisible - session is set to VISIBLE.
22:22:39.54   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:5.3.208.164:6112; (ping=0ms) 100.00%, pending=0, dead=0
22:22:39.54   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=1/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
22:22:39.55   hosting completed successfully
22:22:39.55   HostAsync - completed with HostResult = 0
22:22:39.55   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
22:22:39.55   Activating screen: OnlineGameSetup
22:22:39.55   MessageInternal::CreateChannel: Created channel 534d5347
22:22:39.55   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:22:39.55   MatchInternal::SetMatchType - new type 14 - updating server
22:22:39.55   Transport - Largest received is now 477
22:22:39.57   Transport - Largest received is now 533
22:22:39.57   SetVisible called while !IsConnected
22:22:39.58   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:22:39.58   Activating screen: RelicOnlineChat
22:22:39.58   Activating screen: RelicOnlineNewsScreen
22:22:39.58   Activating screen: RelicOnlineStatsScreen
22:22:39.58   Activating screen: Achievements
22:22:39.58   GAME -- Setting campaign state to 'dlc1'
22:22:39.58   GAME -- Closing state 'dlc1'
22:22:39.59   GAME -- Setting campaign state to 'dlc1'
22:22:39.59   GAME -- Closing state 'dlc1'
22:22:39.59   GAME -- Setting campaign state to 'dlc2'
22:22:39.59   GAME -- Closing state 'dlc2'
22:22:39.59   GAME -- Setting campaign state to 'dlc3'
22:22:39.59   GAME -- Closing state 'dlc3'
22:22:39.59   Transport - Largest received is now 1158
22:22:39.59   GAME -- Setting campaign state to 'dlc1'
22:22:39.60   GAME -- Closing state 'dlc1'
22:22:39.60   Activating screen: GameHistory
22:22:39.60   GAME -- Setting campaign state to 'dlc1'
22:22:39.61   GAME -- Closing state 'dlc1'
22:22:39.61   GAME -- Setting campaign state to 'dlc2'
22:22:39.61   GAME -- Closing state 'dlc2'
22:22:39.61   GAME -- Setting campaign state to 'dlc3'
22:22:39.61   GAME -- Closing state 'dlc3'
22:22:39.61   Transport - Largest received is now 1186
22:22:39.62   Activating screen: OnlineGameSetup
22:22:39.62   Activating screen: RelicOnlineTabs
22:22:39.62   AutomatchInternal::OnHostComplete - Completed Host with success=1
22:22:39.62   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
22:22:39.62   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
22:22:39.62   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:22:39.62   Net::Session::SetVisible - session is set to VISIBLE.
22:22:39.62   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:22:39.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:22:39.74   GAME -- Setting campaign state to 'dlc1'
22:22:39.74   GAME -- Closing state 'dlc1'
22:22:39.74   GAME -- Setting campaign state to 'dlc2'
22:22:39.74   GAME -- Closing state 'dlc2'
22:22:39.74   GAME -- Setting campaign state to 'dlc3'
22:22:39.74   GAME -- Closing state 'dlc3'
22:22:39.79   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:22:42.58   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:22:49.71   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:22:49.71   Net::Session::SetVisible - session is set to VISIBLE.
22:22:49.71   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
22:22:49.75   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:22:49.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:22:55.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.2/0.1, #p/sec[s/r] = 0.6/0.9, max unsent 0, version err 0, merge 0
22:23:03.57   SPDx9 -- 1773MB available Texture Memory
22:23:16.64   Activating screen: RaceSelectionPopup
22:23:17.22   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:23:17.22   Net::Session::SetVisible - session is set to VISIBLE.
22:23:17.22   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
22:23:17.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:23:17.27   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:23:17.75   Activating screen: DynamicPopupMenu
22:23:40.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:5.3.208.164:6112; (ping=0ms) 100.00%, pending=0, dead=0
22:23:40.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=11/12, 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=36/36, frag=0/0, Errors=0/0
22:23:56.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.5/0.5, max unsent 0, version err 0, merge 0
22:24:19.20   SPDx9 -- 1773MB available Texture Memory
22:24:29.98   SPDx9 -- 1773MB available Texture Memory
22:24:41.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:5.3.208.164:6112; (ping=0ms) 100.00%, pending=0, dead=0
22:24:41.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=25/18, frag=0/0, Errors=0/0
22:24:52.39   SPDx9 -- 1773MB available Texture Memory
22:24:53.44   Activating screen: DynamicPopupMenu
22:24:53.79   Activating screen: DynamicPopupMenu
22:24:57.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.5/0.3, max unsent 0, version err 0, merge 0
22:24:59.91   SPDx9 -- 1773MB available Texture Memory
22:25:18.03   Activating screen: MessageBoxPopup
22:25:18.03   Session is marking the local peer PeerID 1 for death
22:25:18.03   Session::GetEvent DestroyPeer success Peer 1 removed
22:25:18.03   Session::DestroyPeer - deallocating peer 1
22:25:18.03   Session - Requested Disconnect for connectionID 2
22:25:18.03   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
22:25:18.03   Session - Requested Disconnect for connectionID 3
22:25:18.03   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
22:25:18.03   AdvertisementInternal::Process - EVENT_DESTROYPEER
22:25:18.03   Destroyed Matchinfo
22:25:18.06   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
22:25:18.06   PeerRemoveAll - flushing local session peer data
22:25:18.06   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
22:25:18.08   Activating screen: FEMovie
22:25:18.08   Activating screen: OnlineWidget
22:25:18.08   Activating screen: FE_mm_01
22:25:18.09   GAME -- Setting campaign state to 'dlc1'
22:25:18.09   GAME -- Closing state 'dlc1'
22:25:18.09   GAME -- Setting campaign state to 'dlc2'
22:25:18.09   GAME -- Closing state 'dlc2'
22:25:18.10   GAME -- Setting campaign state to 'dlc3'
22:25:18.10   GAME -- Closing state 'dlc3'
22:25:18.10   MessageInternal::DestroyChannel: Destroyed channel 534d5347
22:25:18.10   GAME -- Setting campaign state to 'dlc1'
22:25:18.10   GAME -- Closing state 'dlc1'
22:25:18.11   GAME -- Setting campaign state to 'dlc2'
22:25:18.11   GAME -- Closing state 'dlc2'
22:25:18.11   GAME -- Setting campaign state to 'dlc3'
22:25:18.11   GAME -- Closing state 'dlc3'
22:25:18.98   Activating screen: QuitPromptDialog
22:25:19.93   GameApp::Quit( exitValue = 0 )
22:25:19.94   GameApp::ShutFrontEnd
22:25:19.95   GAME -- Ending FE
22:25:19.95   UIFrontEnd - Unloading Front End
22:25:19.97   SOUND -- Shutting down ...
22:25:20.02   SOUND -- Shutdown completed!
22:25:20.05   ~FEAppListener - Flushing queued online notifications
22:25:20.18   DLLDriverLinker -- 2 DLL drivers found.
22:25:20.18   ActionDatabase : [2345] global actions, [0] dummy actions.
22:25:20.18   NetworkManager::Destroy - destroying network manager
22:25:20.18   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
22:25:20.18   MessageInternal::DestroyChannel: Destroyed channel 50525459
22:25:20.18   PartyInternal: Fade to black
22:25:20.18   AutomatchInternal: Fade to black
22:25:20.18   PeerRemoveAll - flushing local session peer data
22:25:20.18   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
22:25:20.18   MessageInternal::DestroyChannel: Destroyed channel 47535450
22:25:20.18   Session - Requested Disconnect for connectionID 1
22:25:20.18   SessionManager::UnregisterSession - Unregistering session 0f9a2e40
22:25:20.18   SessionManager::~SessionManager - uninitializing
22:25:20.19   Net::ThreadFunction - Returning from the network thread function...
22:25:20.19   Transport::~Transport - shutting down transport
22:25:20.19   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
22:25:20.19   Transport::~Connection - closing WINaddr:127.0.0.1:6112;,WINaddr:127.0.0.1:6112;
22:25:20.19   Transport::~Connection - closing WINaddr:192.168.1.100:6112;,WINaddr:192.168.1.100:6112;
22:25:20.19   Transport::~Connection - closing WINaddr:5.3.208.164:6112;,WINaddr:5.3.208.164:6112;
22:25:20.19   Wrote 269 bytes to network datastore login_cache.bin
22:25:20.19   Wrote 52 bytes to network datastore global_cache.bin
22:25:20.19   Wrote 28 bytes to network datastore ping_cache.bin
22:25:20.19   Datastore -- uninitialize complete
22:25:20.19   QuazalInitializer - static uninit of Quazal library
22:25:20.19   QuazalInitializer - unhooking memory 0 currently allocated, 230 allocations, total of 22228 bytes
