2016-10-26 14:17:20.414625 [debug] Client : Logger.cpp:67 : Logger initialized 2016-10-26 14:17:20.414625 [debug] Client : Logger.cpp:68 : v0.4.6+ [build 2016-10-12.f5fa33f] MSVC 2013 2016-10-26 14:17:20.430250 [debug] Client : HumanClientApp.cpp:211 : GL Version String: 3.3.10524 Compatibility Profile Context 2016-10-26 14:17:20.430250 [debug] Client : DependencyVersions.cpp:69 : Dependency versions from headers: 2016-10-26 14:17:20.430250 [debug] Client : DependencyVersions.cpp:74 : Boost: 1_58 2016-10-26 14:17:20.430250 [debug] Client : DependencyVersions.cpp:74 : FreeType: 2.5.5 2016-10-26 14:17:20.430250 [debug] Client : DependencyVersions.cpp:74 : PNG: 1.6.17 2016-10-26 14:17:20.430250 [debug] Client : DependencyVersions.cpp:74 : Python: 2.7.9 2016-10-26 14:17:20.430250 [debug] Client : DependencyVersions.cpp:74 : SDL: 2.0.3 2016-10-26 14:17:20.430250 [debug] Client : DependencyVersions.cpp:74 : zlib: 1.2.8 2016-10-26 14:17:20.883375 [debug] Client : Sound.cpp:339 : OpenAL initialized. Version 1.1 ALSOFT 1.15.1 Renderer OpenAL Soft Vendor OpenAL Community Extensions: AL_EXT_ALAW AL_EXT_DOUBLE AL_EXT_EXPONENT_DISTANCE AL_EXT_FLOAT32 AL_EXT_IMA4 AL_EXT_LINEAR_DISTANCE AL_EXT_MCFORMATS AL_EXT_MULAW AL_EXT_MULAW_MCFORMATS AL_EXT_OFFSET AL_EXT_source_distance_model AL_LOKI_quadriphonic AL_SOFT_buffer_samples AL_SOFT_buffer_sub_data AL_SOFTX_deferred_updates AL_SOFT_direct_channels AL_SOFT_loop_points AL_SOFT_source_latency 2016-10-26 14:17:20.883375 [debug] Client : Sound.cpp:246 : Audio enabled. 2016-10-26 14:17:20.883375 [debug] Client : Hotkeys.cpp:236 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_DOWN' for hotkey map.pan_down 2016-10-26 14:17:20.883375 [debug] Client : Hotkeys.cpp:236 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_LEFT' for hotkey map.pan_left 2016-10-26 14:17:20.883375 [debug] Client : Hotkeys.cpp:236 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_RIGHT' for hotkey map.pan_right 2016-10-26 14:17:20.883375 [debug] Client : Hotkeys.cpp:236 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_UP' for hotkey map.pan_up 2016-10-26 14:17:21.492750 [debug] Client : ClientUI.cpp:432 : loading 14 charsets for current stringtable characters 2016-10-26 14:17:21.492750 [debug] Client : ClientUI.cpp:462 : Loading 14 Unicode charsets: Basic Latin, Latin-1 Supplement, Latin Extended-A, Combining Diacritical Marks, Greek and Coptic, Cyrillic, Arabic, Latin Extended Additional, General Punctuation, Mathematical Operators, Supplemental Arrows-A, Katakana, CJK Unified Ideographs, Hangul Syllables, 2016-10-26 14:17:27.820875 [debug] Client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 2016-10-26 14:17:44.508375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:44.508375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:44.805250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:44.805250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:49.930250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:49.930250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:49.961500 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:49.961500 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.008375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.008375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.102125 [debug] Client : TechTreeWnd.cpp:1400 : Tech Tree Layout Doing Graph Layout 2016-10-26 14:17:50.102125 [debug] Client : TechTreeLayout.cpp:209 : TechTreeLayout::DoLayout creaing place holder nodes... 2016-10-26 14:17:50.102125 [debug] Client : TechTreeWnd.cpp:1407 : Tech Tree Layout Creating Panels 2016-10-26 14:17:50.117750 [debug] Client : TechTreeWnd.cpp:1442 : Tech Tree Layout Done 2016-10-26 14:17:50.117750 [debug] Client : TechTreeWnd.cpp:1752 : Tech List Box Populating 2016-10-26 14:17:50.258375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.258375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.508375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.508375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.508375 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.680250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.680250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.680250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.680250 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.695875 [debug] Client : Tech.cpp:152 : SourceForEmpire: Unable to get empire with ID: -1 2016-10-26 14:17:50.711500 [debug] Client : TechTreeWnd.cpp:1791 : Tech List Box Done Populating 2016-10-26 14:17:50.711500 [debug] Client : TechTreeWnd.cpp:1792 : Creation time=452ms 2016-10-26 14:17:50.711500 [debug] Client : TechTreeWnd.cpp:1793 : Insertion time=79ms 2016-10-26 14:17:51.383375 [debug] Client : DesignWnd.cpp:1603 : BasesListBox::Populate 2016-10-26 14:17:51.383375 [debug] Client : DesignWnd.cpp:1761 : BasesListBox::PopulateWithSavedDesigns 2016-10-26 14:17:51.414625 [debug] Client : DesignWnd.cpp:2845 : DesignWnd::MainPanel::ReregisterDesigns 2016-10-26 14:17:51.836500 [debug] Client : HumanClientApp.cpp:1183 : Limited FPS to 60 2016-10-26 14:17:51.852125 [debug] Client : HumanClientApp.cpp:155 : OpenGL Version Number: 3.3 2016-10-26 14:17:51.852125 [debug] Client : HumanClientFSM.cpp:61 : (HumanClientFSM) IntroMenu 2016-10-26 14:17:51.852125 [debug] Client : HumanClientApp.cpp:426 : HumanClientApp::KillServer() 2016-10-26 14:17:51.852125 [debug] Client : Process.cpp:65 : Process::Kill 2016-10-26 14:17:51.852125 [debug] Client : Process.cpp:70 : Process::Kill found no m_impl 2016-10-26 14:17:51.852125 [debug] Client : Process.cpp:72 : Process::Kill calling RequestTermination() 2016-10-26 14:17:51.852125 [debug] Client : ClientNetworking.cpp:247 : ClientNetworking::SetPlayerID: player id set to: -1 2016-10-26 14:17:51.852125 [debug] Client : HumanClientApp.cpp:932 : HumanClientApp::HandleFocusChange(Gained Focus) 2016-10-26 14:18:28.477125 [debug] Client : HumanClientApp.cpp:932 : HumanClientApp::HandleFocusChange(Lost Focus) 2016-10-26 14:25:00.195875 [debug] Client : HumanClientApp.cpp:932 : HumanClientApp::HandleFocusChange(Gained Focus) 2016-10-26 14:25:02.352125 [debug] Client : HumanClientApp.cpp:618 : HumanClientApp::LoadSinglePlayerGame 2016-10-26 14:25:02.352125 [debug] Client : SaveFileDialog.cpp:516 : SaveFileDialog::FilterColumns: Visible columns: 5 2016-10-26 14:25:02.352125 [debug] Client : SaveFileDialog.cpp:618 : pathstring: C:\Documents and Settings\Eric\Application Data\FreeOrion\save 2016-10-26 14:25:02.399000 [debug] Client : SaveFileDialog.cpp:854 : SaveFileDialog::UpdatePreviewList 2016-10-26 14:25:02.399000 [debug] Client : SaveFileDialog.cpp:472 : SaveFileDialog::LoadDirectories name: auto valid UTF-8: true 2016-10-26 14:25:02.430250 [debug] Client : SaveGamePreviewUtils.cpp:66 : LoadSaveGamePreviewData: Loading preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161016_174126.sav 2016-10-26 14:25:02.445875 [debug] Client : ScopedTimer.cpp:29 : LoadSaveGamePreviewData (binary): C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161016_174126.sav time: 15 ms 2016-10-26 14:25:02.445875 [debug] Client : SaveGamePreviewUtils.cpp:83 : Deserializing XML data 2016-10-26 14:25:02.445875 [debug] Client : SaveGamePreviewUtils.cpp:89 : Loaded preview with: 1 human players 2016-10-26 14:25:02.445875 [debug] Client : SaveGamePreviewUtils.cpp:97 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161016_174126.sav 2016-10-26 14:25:02.445875 [debug] Client : SaveGamePreviewUtils.cpp:66 : LoadSaveGamePreviewData: Loading preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161017_232851.sav 2016-10-26 14:25:02.477125 [debug] Client : ScopedTimer.cpp:29 : LoadSaveGamePreviewData (binary): C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161017_232851.sav time: 19 ms 2016-10-26 14:25:02.477125 [debug] Client : SaveGamePreviewUtils.cpp:83 : Deserializing XML data 2016-10-26 14:25:02.477125 [debug] Client : SaveGamePreviewUtils.cpp:89 : Loaded preview with: 1 human players 2016-10-26 14:25:02.477125 [debug] Client : SaveGamePreviewUtils.cpp:97 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161017_232851.sav 2016-10-26 14:25:02.477125 [debug] Client : SaveGamePreviewUtils.cpp:66 : LoadSaveGamePreviewData: Loading preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161025_061518.sav 2016-10-26 14:25:02.492750 [debug] Client : ScopedTimer.cpp:29 : LoadSaveGamePreviewData (binary): C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161025_061518.sav time: 14 ms 2016-10-26 14:25:02.492750 [debug] Client : SaveGamePreviewUtils.cpp:83 : Deserializing XML data 2016-10-26 14:25:02.524000 [debug] Client : SaveGamePreviewUtils.cpp:89 : Loaded preview with: 1 human players 2016-10-26 14:25:02.524000 [debug] Client : SaveGamePreviewUtils.cpp:97 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161025_061518.sav 2016-10-26 14:25:02.524000 [debug] Client : SaveGamePreviewUtils.cpp:66 : LoadSaveGamePreviewData: Loading preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161025_114838.sav 2016-10-26 14:25:02.539625 [debug] Client : ScopedTimer.cpp:29 : LoadSaveGamePreviewData (binary): C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161025_114838.sav time: 15 ms 2016-10-26 14:25:02.539625 [debug] Client : SaveGamePreviewUtils.cpp:83 : Deserializing XML data 2016-10-26 14:25:02.570875 [debug] Client : SaveGamePreviewUtils.cpp:89 : Loaded preview with: 1 human players 2016-10-26 14:25:02.570875 [debug] Client : SaveGamePreviewUtils.cpp:97 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161025_114838.sav 2016-10-26 14:25:29.289625 [debug] Client : SaveFileDialog.cpp:729 : SaveFileDialog::Confirm: Confirming 2016-10-26 14:25:29.289625 [debug] Client : SaveFileDialog.cpp:745 : choice: save-20161025_114838.sav valid utf-8: true 2016-10-26 14:25:29.289625 [debug] Client : SaveFileDialog.cpp:748 : current dir PathString: C:\Documents and Settings\Eric\Application Data\FreeOrion\save valid utf-8: true 2016-10-26 14:25:29.289625 [debug] Client : SaveFileDialog.cpp:751 : chosen_full_path PathString: C:\Documents and Settings\Eric\Application Data\FreeOrion\save\save-20161025_114838.sav valid utf-8: true 2016-10-26 14:25:29.289625 [debug] Client : SaveFileDialog.cpp:752 : chosen_full_path is directory? : false 2016-10-26 14:25:29.336500 [debug] Client : HumanClientApp.cpp:650 : HumanClientApp::LoadSinglePlayerGame() not already in a game, so don't need to end it 2016-10-26 14:25:29.336500 [debug] Client : HumanClientApp.cpp:655 : HumanClientApp::LoadSinglePlayerGame() Starting server 2016-10-26 14:25:29.336500 [debug] Client : HumanClientApp.cpp:380 : HumanClientApp::StartServer: C:\Program Files\FreeOrion\freeoriond.exe 2016-10-26 14:25:29.336500 [debug] Client : HumanClientApp.cpp:410 : ai-config not set. 2016-10-26 14:25:29.617750 [debug] Client : HumanClientApp.cpp:657 : HumanClientApp::LoadSinglePlayerGame() Server started 2016-10-26 14:25:29.617750 [debug] Client : HumanClientApp.cpp:662 : HumanClientApp::LoadSinglePlayerGame() Connecting to server 2016-10-26 14:25:29.617750 [debug] Client : ClientNetworking.cpp:168 : ClientNetworking::ConnectToServer : attempting to connect to server at 127.0.0.1 2016-10-26 14:25:29.617750 [debug] Client : ClientNetworking.cpp:180 : tcp::resolver::iterator host_name: 127.0.0.1 address: 127.0.0.1 port: 12346 2016-10-26 14:25:30.977125 [debug] Client : ClientNetworking.cpp:198 : ClientNetworking::ConnectToServer : connected to server 2016-10-26 14:25:30.977125 [debug] Client : ClientNetworking.cpp:202 : ClientNetworking::ConnectToServer : this client using xml serialization. 2016-10-26 14:25:30.977125 [debug] Client : ClientNetworking.cpp:205 : ClientNetworking::ConnectToServer : starting networking thread 2016-10-26 14:25:30.977125 [debug] Client : HumanClientApp.cpp:673 : HumanClientApp::LoadSinglePlayerGame() Connected to server 2016-10-26 14:25:30.977125 [debug] Client : ClientNetworking.cpp:247 : ClientNetworking::SetPlayerID: player id set to: -1 2016-10-26 14:25:30.977125 [debug] Client : HumanClientFSM.cpp:77 : (HumanClientFSM) IntroMenu.HostSPGameRequested 2016-10-26 14:25:30.977125 [debug] Client : HumanClientFSM.cpp:73 : (HumanClientFSM) ~IntroMenu 2016-10-26 14:25:30.977125 [debug] Client : HumanClientFSM.cpp:100 : (HumanClientFSM) WaitingForSPHostAck 2016-10-26 14:25:39.789625 [debug] Client : HumanClientFSM.cpp:106 : (HumanClientFSM) WaitingForSPHostAck.HostSPGame 2016-10-26 14:25:39.789625 [debug] Client : ClientNetworking.cpp:247 : ClientNetworking::SetPlayerID: player id set to: 1 2016-10-26 14:25:39.805250 [debug] Client : SitRepPanel.cpp:630 : SitRepPanel::Update() 2016-10-26 14:25:39.867750 [debug] Client : DesignWnd.cpp:2845 : DesignWnd::MainPanel::ReregisterDesigns 2016-10-26 14:25:39.867750 [debug] Client : HumanClientFSM.cpp:103 : (HumanClientFSM) ~WaitingForSPHostAck 2016-10-26 14:25:39.867750 [debug] Client : HumanClientFSM.cpp:337 : (HumanClientFSM) PlayingGame 2016-10-26 14:25:39.867750 [debug] Client : HumanClientFSM.cpp:525 : (HumanClientFSM) WaitingForGameStart 2016-10-26 14:25:39.914625 [debug] Client : HumanClientFSM.cpp:499 : (HumanClientFSM) PlayingGame.TurnProgress 2016-10-26 14:26:08.586500 [debug] Client : HumanClientFSM.cpp:499 : (HumanClientFSM) PlayingGame.TurnProgress 2016-10-26 14:26:26.695875 [debug] Client : HumanClientFSM.cpp:537 : (HumanClientFSM) WaitingForGameStart.GameStart 2016-10-26 14:26:33.492750 [debug] Client : Message.cpp:712 : ExtractMessage empire deserialization time 47 2016-10-26 14:26:33.695875 [debug] Client : SerializeUniverse.cpp:70 : Universe::serialize : deserializing universe width: 1166.67 2016-10-26 14:26:33.695875 [debug] Client : SerializeUniverse.cpp:75 : Universe::serialize : deserializing 0 ship designs 2016-10-26 14:26:33.695875 [debug] Client : SerializeUniverse.cpp:83 : Universe::serialize : deserializing empire object visibility for 1, 1, 1, 1 empires 2016-10-26 14:26:33.727125 [debug] Client : SerializeUniverse.cpp:96 : Universe::serialize : deserializing 517 objects 2016-10-26 14:26:33.727125 [debug] Client : SerializeUniverse.cpp:102 : Universe::serialize : deserializing 191 destroyed object ids 2016-10-26 14:26:33.727125 [debug] Client : SerializeUniverse.cpp:109 : Universe::serialize : deserializing empire known objects for 0 empires 2016-10-26 14:26:33.727125 [debug] Client : SerializeUniverse.cpp:114 : Universe::serialize : deserializing last allocated ids 2016-10-26 14:26:33.758375 [debug] Client : SerializeUniverse.cpp:118 : Universe::serialize : deserializing 18 types of statistic 2016-10-26 14:26:33.758375 [debug] Client : SerializeUniverse.cpp:120 : Universe::serialize : deserializing done 2016-10-26 14:26:33.758375 [debug] Client : SerializeUniverse.cpp:132 : Universe::serialize : updating empires' latest known object destruction states 2016-10-26 14:26:33.758375 [debug] Client : SerializeUniverse.cpp:143 : Universe::serialize done 2016-10-26 14:26:33.758375 [debug] Client : Message.cpp:720 : ExtractMessage universe deserialization time 62 2016-10-26 14:26:33.758375 [debug] Client : HumanClientFSM.cpp:557 : Extracted GameStart message for turn: 130 with empire: 1 2016-10-26 14:26:33.758375 [debug] Client : ProductionWnd.cpp:954 : ProductionWnd::UpdateQueue() 2016-10-26 14:26:33.961500 [debug] Client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 2016-10-26 14:26:34.195875 [debug] Client : TechTreeWnd.cpp:1400 : Tech Tree Layout Doing Graph Layout 2016-10-26 14:26:34.195875 [debug] Client : TechTreeLayout.cpp:209 : TechTreeLayout::DoLayout creaing place holder nodes... 2016-10-26 14:26:34.195875 [debug] Client : TechTreeWnd.cpp:1407 : Tech Tree Layout Creating Panels 2016-10-26 14:26:34.195875 [debug] Client : TechTreeWnd.cpp:1442 : Tech Tree Layout Done 2016-10-26 14:26:34.211500 [debug] Client : ResearchWnd.cpp:480 : ResearchWnd::UpdateQueue() 2016-10-26 14:26:34.227125 [debug] Client : HumanClientFSM.cpp:534 : (HumanClientFSM) ~WaitingForGameStart 2016-10-26 14:26:34.227125 [debug] Client : HumanClientFSM.cpp:646 : (HumanClientFSM) PlayingTurn 2016-10-26 14:26:34.227125 [debug] Client : MapWnd.cpp:2305 : Initializing turn 130 2016-10-26 14:26:34.227125 [debug] Client : Universe.cpp:1325 : Universe::InitMeterEstimatesAndDiscrepancies 2016-10-26 14:26:34.227125 [debug] Client : Universe.cpp:1332 : IMEAD: updating meter estimates 2016-10-26 14:26:34.539625 [debug] Client : Universe.cpp:2257 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 16 hulls/parts: 0 fields: 203 2016-10-26 14:26:34.539625 [debug] Client : Universe.cpp:2264 : Evaluation time: 312 reorder time: 0 2016-10-26 14:26:34.570875 [debug] Client : ScopedTimer.cpp:29 : Universe::ExecuteEffects time: 12 ms 2016-10-26 14:26:34.570875 [debug] Client : ScopedTimer.cpp:29 : Universe::UpdateMeterEstimatesImpl on 0 objects time: 357 ms 2016-10-26 14:26:34.586500 [debug] Client : Universe.cpp:1337 : IMEAD: determining discrepancies 2016-10-26 14:26:34.586500 [debug] Client : OrderSet.cpp:28 : OrderSet::ApplyOrders() executing 4 orders 2016-10-26 14:26:34.586500 [debug] Client : Order.cpp:375 : FleetMoveOrder::ExecuteImpl Setting route of fleet 2349 to 431 249 382 2016-10-26 14:26:34.586500 [debug] Client : Order.cpp:375 : FleetMoveOrder::ExecuteImpl Setting route of fleet 2348 to 431 249 2016-10-26 14:26:34.586500 [debug] Client : Order.cpp:375 : FleetMoveOrder::ExecuteImpl Setting route of fleet 2346 to 431 249 2016-10-26 14:26:34.586500 [debug] Client : Order.cpp:375 : FleetMoveOrder::ExecuteImpl Setting route of fleet 2347 to 431 249 2016-10-26 14:26:34.711500 [debug] Client : Universe.cpp:2257 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 16 buildings: 0 hulls/parts: 0 fields: 0 2016-10-26 14:26:34.711500 [debug] Client : Universe.cpp:2264 : Evaluation time: 110 reorder time: 15 2016-10-26 14:26:34.727125 [debug] Client : ScopedTimer.cpp:29 : Universe::ExecuteEffects time: 14 ms 2016-10-26 14:26:34.727125 [debug] Client : ScopedTimer.cpp:29 : Universe::UpdateMeterEstimatesImpl on 0 objects time: 143 ms 2016-10-26 14:26:34.914625 [debug] Client : Universe.cpp:2257 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 16 buildings: 0 hulls/parts: 0 fields: 0 2016-10-26 14:26:34.914625 [debug] Client : Universe.cpp:2264 : Evaluation time: 172 reorder time: 15 2016-10-26 14:26:34.930250 [debug] Client : ScopedTimer.cpp:29 : Universe::ExecuteEffects time: 3407 µs 2016-10-26 14:26:34.930250 [debug] Client : MapWnd.cpp:2493 : MapWnd::InitTurnRendering 2016-10-26 14:26:35.539625 [debug] Client : MapWnd.cpp:2604 : MapWnd::InitSystemRenderingBuffers 2016-10-26 14:26:35.711500 [debug] Client : ScopedTimer.cpp:29 : MapWnd::InitSystemRenderingBuffers time: 171 ms 2016-10-26 14:26:35.711500 [debug] Client : MapWnd.cpp:3017 : MapWnd::InitStarlaneRenderingBuffers 2016-10-26 14:26:35.711500 [debug] Client : ScopedTimer.cpp:29 : MapWnd::InitStarlaneRenderingBuffers time: 1249 µs 2016-10-26 14:26:37.055250 [debug] Client : MapWnd.cpp:3357 : MapWnd::InitFieldRenderingBuffers 2016-10-26 14:26:37.055250 [debug] Client : MapWnd.cpp:3469 : MapWnd::InitVisibilityRadiiRenderingBuffers 2016-10-26 14:26:37.055250 [debug] Client : ScopedTimer.cpp:29 : MapWnd::InitVisibilityRadiiRenderingBuffers time: 1819 µs 2016-10-26 14:26:37.055250 [debug] Client : ScopedTimer.cpp:29 : MapWnd::InitTurnRendering time: 2121 ms 2016-10-26 14:26:37.055250 [debug] Client : ScopedTimer.cpp:29 : AddFleetsStateChangedSignal() time: 5207 µs 2016-10-26 14:26:37.055250 [debug] Client : ScopedTimer.cpp:29 : RefreshFleetSignals() time: 5486 µs 2016-10-26 14:26:37.055250 [debug] Client : MapWnd.cpp:2360 : showing intro sitreps : false 2016-10-26 14:26:37.367750 [debug] Client : SitRepPanel.cpp:630 : SitRepPanel::Update() 2016-10-26 14:26:37.539625 [debug] Client : SitRepPanel.cpp:630 : SitRepPanel::Update() 2016-10-26 14:26:37.649000 [debug] Client : ResearchWnd.cpp:480 : ResearchWnd::UpdateQueue() 2016-10-26 14:26:37.664625 [debug] Client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 2016-10-26 14:26:37.899000 [debug] Client : TechTreeWnd.cpp:1400 : Tech Tree Layout Doing Graph Layout 2016-10-26 14:26:37.899000 [debug] Client : TechTreeLayout.cpp:209 : TechTreeLayout::DoLayout creaing place holder nodes... 2016-10-26 14:26:37.899000 [debug] Client : TechTreeWnd.cpp:1407 : Tech Tree Layout Creating Panels 2016-10-26 14:26:37.899000 [debug] Client : TechTreeWnd.cpp:1442 : Tech Tree Layout Done 2016-10-26 14:26:37.914625 [debug] Client : Empire.cpp:3403 : ========= Production Update for empire: 1 ======== 2016-10-26 14:26:37.930250 [debug] Client : Empire.cpp:1063 : ProductionQueue::Update: Simulating future turns of production queue 2016-10-26 14:26:37.930250 [debug] Client : Empire.cpp:1279 : ProductionQueue::Update: Projections took 0 microseconds with 162.213 total Production Points 2016-10-26 14:26:37.930250 [debug] Client : ProductionWnd.cpp:954 : ProductionWnd::UpdateQueue() 2016-10-26 14:26:38.024000 [debug] Client : MapWnd.cpp:3017 : MapWnd::InitStarlaneRenderingBuffers 2016-10-26 14:26:38.024000 [debug] Client : ScopedTimer.cpp:29 : MapWnd::InitStarlaneRenderingBuffers time: 1454 µs 2016-10-26 14:26:38.117750 [debug] Client : Empire.cpp:3403 : ========= Production Update for empire: 2 ======== 2016-10-26 14:26:38.133375 [debug] Client : Empire.cpp:1049 : not enough PP to be worth simulating future turns production. marking everything as never complete 2016-10-26 14:26:38.133375 [debug] Client : Empire.cpp:3403 : ========= Production Update for empire: 3 ======== 2016-10-26 14:26:38.133375 [debug] Client : Empire.cpp:1049 : not enough PP to be worth simulating future turns production. marking everything as never complete 2016-10-26 14:26:38.133375 [debug] Client : Empire.cpp:3403 : ========= Production Update for empire: 4 ======== 2016-10-26 14:26:38.133375 [debug] Client : Empire.cpp:1049 : not enough PP to be worth simulating future turns production. marking everything as never complete 2016-10-26 14:26:38.133375 [debug] Client : Empire.cpp:3403 : ========= Production Update for empire: 5 ======== 2016-10-26 14:26:38.133375 [debug] Client : Empire.cpp:1049 : not enough PP to be worth simulating future turns production. marking everything as never complete 2016-10-26 14:26:38.149000 [debug] Client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 2016-10-26 14:26:38.383375 [debug] Client : TechTreeWnd.cpp:1400 : Tech Tree Layout Doing Graph Layout 2016-10-26 14:26:38.383375 [debug] Client : TechTreeLayout.cpp:209 : TechTreeLayout::DoLayout creaing place holder nodes... 2016-10-26 14:26:38.383375 [debug] Client : TechTreeWnd.cpp:1407 : Tech Tree Layout Creating Panels 2016-10-26 14:26:38.383375 [debug] Client : TechTreeWnd.cpp:1442 : Tech Tree Layout Done 2016-10-26 14:26:38.399000 [debug] Client : ResearchWnd.cpp:480 : ResearchWnd::UpdateQueue() 2016-10-26 14:26:38.414625 [debug] Client : ProductionWnd.cpp:954 : ProductionWnd::UpdateQueue() 2016-10-26 14:26:38.508375 [debug] Client : MapWnd.cpp:6393 : MapWnd::DispatchFleetsExploring called 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - meter estimates time: 710 ms 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - rendering time: 2121 ms 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - fleet signals time: 6804 µs 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - sitreps time: 561 ms 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - update resource pools time: 515 ms 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - refresh research time: 273 ms 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - refresh production wnd time: 86 ms 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:173 : MapWnd::InitTurn - refresh indicators time: 11 ms 2016-10-26 14:26:38.508375 [debug] Client : ScopedTimer.cpp:183 : MapWnd::InitTurn time: 4288 ms 2016-10-26 14:26:54.445875 [debug] Client : HumanClientApp.cpp:932 : HumanClientApp::HandleFocusChange(Lost Focus) 2016-10-26 14:28:25.289625 [debug] Client : HumanClientFSM.cpp:741 : (HumanClientFSM) PlayingTurn.PlayerStatus 2016-10-26 14:28:25.820875 [debug] Client : HumanClientFSM.cpp:741 : (HumanClientFSM) PlayingTurn.PlayerStatus 2016-10-26 14:28:25.883375 [debug] Client : HumanClientFSM.cpp:741 : (HumanClientFSM) PlayingTurn.PlayerStatus 2016-10-26 14:28:26.789625 [debug] Client : HumanClientFSM.cpp:741 : (HumanClientFSM) PlayingTurn.PlayerStatus