16:54:52.696632 [info] log : Logger.cpp:203 : Added logger named "log" 16:54:52.699636 [info] log : Logger.cpp:203 : Added logger named "IDallocator" 16:54:52.700650 [info] log : Logger.cpp:372 : Logger initialized at Tue Aug 22 16:54:52 2017 16:54:52.700650 [info] log : Logger.cpp:335 : Setting "log" logger threshold to "debug". 16:54:52.700650 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "log" from optionsDB using threshold debug 16:54:52.701161 [info] log : Logger.cpp:335 : Setting "client" logger threshold to "debug". 16:54:52.701161 [info] log : Logger.cpp:335 : Setting "IDallocator" logger threshold to "debug". 16:54:52.701161 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "IDallocator" from optionsDB using threshold debug 16:54:52.701161 [info] log : Logger.cpp:335 : Setting "log" logger threshold to "debug". 16:54:52.701161 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "log" from optionsDB using threshold debug 16:54:52.701642 [info] log : LoggerWithOptionsDB.cpp:91 : Initialized OptionsDB logging configuration. 16:54:52.701642 [info] log : Logger.cpp:335 : Setting "ai" logger threshold to "debug". 16:54:52.701642 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "ai" from optionsDB using threshold debug 16:54:52.701642 [info] log : Logger.cpp:335 : Setting "client" logger threshold to "debug". 16:54:52.701642 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "client" from optionsDB using threshold debug 16:54:52.701642 [info] log : Logger.cpp:335 : Setting "server" logger threshold to "debug". 16:54:52.702140 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "server" from optionsDB using threshold debug 16:54:52.702140 [info] log : Logger.cpp:335 : Setting "combat_log" logger threshold to "debug". 16:54:52.702140 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "combat_log" from optionsDB using threshold debug 16:54:52.702140 [info] log : Logger.cpp:335 : Setting "combat" logger threshold to "debug". 16:54:52.702140 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "combat" from optionsDB using threshold debug 16:54:52.702140 [info] log : Logger.cpp:335 : Setting "effects" logger threshold to "debug". 16:54:52.702642 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "effects" from optionsDB using threshold debug 16:54:52.702642 [info] log : Logger.cpp:335 : Setting "FSM" logger threshold to "debug". 16:54:52.702642 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "FSM" from optionsDB using threshold debug 16:54:52.702642 [info] log : Logger.cpp:335 : Setting "network" logger threshold to "debug". 16:54:52.702642 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "network" from optionsDB using threshold debug 16:54:52.702642 [info] log : Logger.cpp:335 : Setting "python" logger threshold to "debug". 16:54:52.702642 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "python" from optionsDB using threshold debug 16:54:52.703142 [info] client : HumanClientApp.cpp:240 : v0.4.7+ [build 2017-08-21.7ca62b4] MSVC 2015 16:54:52.703142 [info] client : HumanClientApp.cpp:243 : GL Version String: 4.5.0 NVIDIA 382.53 16:54:52.703142 [info] client : DependencyVersions.cpp:81 : Dependency versions from headers: 16:54:52.703142 [info] client : DependencyVersions.cpp:84 : Boost: 1_59 16:54:52.703142 [info] client : DependencyVersions.cpp:84 : FreeType: 2.5.5 16:54:52.703142 [info] client : DependencyVersions.cpp:84 : PNG: 1.6.29 16:54:52.703643 [info] client : DependencyVersions.cpp:84 : SDL: 2.0.4 16:54:52.703643 [info] client : DependencyVersions.cpp:84 : libvorbis: Xiph.Org libVorbis 1.3.5 16:54:52.703643 [info] client : DependencyVersions.cpp:84 : zlib: 1.2.8 16:54:52.728180 [debug] client : Sound.cpp:355 : OpenAL initialized. Version 1.1 ALSOFT 1.17.2 Renderer OpenAL Soft Vendor OpenAL Community Extensions: AL_EXT_ALAW AL_EXT_BFORMAT 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_BFORMAT AL_EXT_MULAW_MCFORMATS AL_EXT_OFFSET AL_EXT_source_distance_model AL_LOKI_quadriphonic AL_SOFT_block_alignment AL_SOFT_buffer_samples AL_SOFT_buffer_sub_data AL_SOFT_deferred_updates AL_SOFT_direct_channels AL_SOFT_loop_points AL_SOFT_MSADPCM AL_SOFT_source_latency AL_SOFT_source_length 16:54:52.728180 [debug] client : Sound.cpp:252 : Audio enabled. 16:54:52.728180 [debug] client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_DOWN' for hotkey map.pan_down 16:54:52.728681 [debug] client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_LEFT' for hotkey map.pan_left 16:54:52.728681 [debug] client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_RIGHT' for hotkey map.pan_right 16:54:52.728681 [debug] client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_UP' for hotkey map.pan_up 16:54:52.810968 [debug] client : ClientUI.cpp:437 : loading 14 charsets for current stringtable characters 16:54:52.811469 [debug] client : ClientUI.cpp:466 : 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, 16:54:53.171523 [debug] client : HumanClientApp.cpp:1261 : Limited FPS to 60 16:54:53.174535 [debug] client : HumanClientApp.cpp:160 : OpenGL Version Number: 4.5 16:54:53.216094 [info] log : Logger.cpp:203 : Added logger named "FSM" 16:54:53.216592 [info] log : Logger.cpp:335 : Setting "FSM" logger threshold to "debug". 16:54:53.216592 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "FSM" from optionsDB using threshold debug 16:54:53.228108 [debug] client : HumanClientApp.cpp:965 : HumanClientApp::HandleFocusChange(Gained Focus) 16:54:53.447461 [debug] client : SitRepPanel.cpp:725 : SitRepPanel::Update() 16:54:55.338688 [trace] client : Tech.cpp:432 : TechManager checksum: 7261613 16:54:56.728702 [trace] client : ShipDesign.cpp:206 : PartTypeManager checksum: 9844865 16:54:57.062724 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_RESEED_PRNG_SERVER with default value true 16:54:57.062724 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_STARLANES_EVERYWHERE with default value false 16:54:57.062724 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_CHEAP_AND_FAST_SHIP_PRODUCTION with default value false 16:54:57.062724 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_SHIP_SPEED_FACTOR with default value 1 16:54:57.062724 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_SHIP_STRUCTURE_FACTOR with default value 1 16:54:57.062724 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_CHEAP_AND_FAST_BUILDING_PRODUCTION with default value false 16:54:57.062724 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_CHEAP_AND_FAST_TECH_RESEARCH with default value false 16:54:57.063216 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_NUM_COMBAT_ROUNDS with default value 3 16:54:57.065233 [debug] client : GameRulesParser.cpp:48 : Adding Double game rule with name: RULE_SHIP_HULL_COST_FACTOR, desc: RULE_SHIP_HULL_COST_FACTOR_DESC, default: 1, min: 0.1, max: 10 16:54:57.065233 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_SHIP_HULL_COST_FACTOR with default value 1 16:54:57.065233 [debug] client : GameRulesParser.cpp:48 : Adding Double game rule with name: RULE_SHIP_PART_COST_FACTOR, desc: RULE_SHIP_PART_COST_FACTOR_DESC, default: 1, min: 0.1, max: 10 16:54:57.065734 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_SHIP_PART_COST_FACTOR with default value 1 16:54:57.065734 [debug] client : GameRulesParser.cpp:48 : Adding Double game rule with name: RULE_TECH_COST_FACTOR, desc: RULE_TECH_COST_FACTOR_DESC, default: 2, min: 0.1, max: 10 16:54:57.065734 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_TECH_COST_FACTOR with default value 2 16:54:57.065734 [debug] client : GameRulesParser.cpp:48 : Adding Double game rule with name: RULE_BUILDING_COST_FACTOR, desc: RULE_BUILDING_COST_FACTOR_DESC, default: 1, min: 0.1, max: 10 16:54:57.065734 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_BUILDING_COST_FACTOR with default value 1 16:54:57.065734 [debug] client : GameRulesParser.cpp:28 : Adding Boolean game rule with name: RULE_ENABLE_EXPERIMENTORS, desc: RULE_ENABLE_EXPERIMENTORS_DESC, default: true 16:54:57.066229 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_ENABLE_EXPERIMENTORS with default value true 16:54:57.066229 [debug] client : GameRulesParser.cpp:63 : Adding String game rule with name: RULE_TEST_STRING, desc: RULE_TEST_STRING_DESC, default: "HUMAN_PLAYER", allowed: "AI_PLAYER", "HUMAN_PLAYER", "MODERATOR", "OBSERVER", 16:54:57.066229 [debug] client : MultiplayerCommon.h:120 : Added game rule named RULE_TEST_STRING with default value HUMAN_PLAYER 16:54:57.066229 [debug] client : MultiplayerCommon.cpp:75 : Registered and Parsed Game Rules: 16:54:57.066229 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_SHIP_HULL_COST_FACTOR : 1 16:54:57.066229 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_STARLANES_EVERYWHERE : 0 16:54:57.066229 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_RESEED_PRNG_SERVER : 1 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_CHEAP_AND_FAST_SHIP_PRODUCTION : 0 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_SHIP_SPEED_FACTOR : 1 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_SHIP_STRUCTURE_FACTOR : 1 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_CHEAP_AND_FAST_BUILDING_PRODUCTION : 0 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_NUM_COMBAT_ROUNDS : 3 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_CHEAP_AND_FAST_TECH_RESEARCH : 0 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_TEST_STRING : HUMAN_PLAYER 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_SHIP_PART_COST_FACTOR : 1 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_BUILDING_COST_FACTOR : 1 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_TECH_COST_FACTOR : 2 16:54:57.066720 [debug] client : MultiplayerCommon.cpp:77 : ... RULE_ENABLE_EXPERIMENTORS : 1 16:54:57.649449 [debug] client : DesignWnd.cpp:1970 : BasesListBox::Populate 16:54:57.649449 [debug] client : DesignWnd.cpp:2120 : EmptyHulls::PopulateCore EmpireID(): -1 16:54:58.989346 [trace] client : ShipDesign.cpp:660 : HullTypeManager checksum: 9650820 16:55:02.517438 [debug] client : HumanClientApp.cpp:411 : HumanClientApp::StartServer: C:\Program Files (x86)\FreeOrion\freeoriond.exe 16:55:02.517438 [debug] client : HumanClientApp.cpp:445 : ai-config not set. 16:55:07.981384 [trace] client : Species.cpp:378 : SpeciesManager checksum: 8701840 16:55:10.634470 [info] log : Logger.cpp:203 : Added logger named "network" 16:55:10.634470 [info] log : Logger.cpp:335 : Setting "network" logger threshold to "debug". 16:55:10.634470 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "network" from optionsDB using threshold debug 16:55:10.634470 [debug] network : ClientNetworking.cpp:317 : Attempt to connect to server at one of these addresses: 16:55:10.634957 [debug] network : ClientNetworking.cpp:319 : tcp::resolver::iterator host_name: 127.0.0.1 address: 127.0.0.1 port: 12346 16:55:10.635457 [debug] network : ClientNetworking.cpp:338 : Connected to server at host_name: 127.0.0.1 address: 127.0.0.1 port: 12346 16:55:10.635457 [debug] network : ClientNetworking.cpp:362 : Connecting to server took 1 ms. 16:55:10.635958 [debug] network : ClientNetworking.cpp:365 : ConnectToServer() : starting networking thread 16:55:27.276390 [info] client : HumanClientFSM.cpp:234 : Got checksum message from server: 16:55:27.276390 [info] client : HumanClientFSM.cpp:236 : BuildingTypeManager : 8776260 16:55:27.276390 [info] client : HumanClientFSM.cpp:236 : Encyclopedia : 884914 16:55:27.276390 [info] client : HumanClientFSM.cpp:236 : FieldTypeManager : 8837675 16:55:27.276891 [info] client : HumanClientFSM.cpp:236 : HullTypeManager : 9650820 16:55:27.276891 [info] client : HumanClientFSM.cpp:236 : PartTypeManager : 9844865 16:55:27.276891 [info] client : HumanClientFSM.cpp:236 : PredefinedShipDesignManager : 875028 16:55:27.276891 [info] client : HumanClientFSM.cpp:236 : SpeciesManager : 8701840 16:55:27.276891 [info] client : HumanClientFSM.cpp:236 : TechManager : 7261613 16:55:27.293416 [debug] network : ClientNetworking.cpp:421 : ClientNetworking::SetPlayerID: player id set to: 1 16:55:27.300426 [debug] client : SitRepPanel.cpp:725 : SitRepPanel::Update() 16:55:27.324963 [debug] client : DesignWnd.cpp:1970 : BasesListBox::Populate 16:55:27.324963 [debug] client : DesignWnd.cpp:2120 : EmptyHulls::PopulateCore EmpireID(): -1 16:55:51.216969 [debug] client : HumanClientApp.cpp:965 : HumanClientApp::HandleFocusChange(Lost Focus) 16:55:53.559616 [debug] client : HumanClientApp.cpp:965 : HumanClientApp::HandleFocusChange(Gained Focus) 16:56:00.031643 [debug] client : Message.cpp:751 : ExtractGameStartMessage empire deserialization time 0 16:56:00.031643 [debug] client : Universe.cpp:179 : Reset id allocators with highest object id = -1 and highest design id = -1 16:56:00.031643 [debug] client : SerializeUniverse.cpp:76 : Universe::serialize : deserializing universe width: 1458.83 16:56:00.032645 [debug] client : SerializeUniverse.cpp:81 : Universe::serialize : deserializing 0 ship designs 16:56:00.032645 [debug] client : SerializeUniverse.cpp:89 : Universe::serialize : deserializing empire object visibility for 1, 1, 0, 0 empires 16:56:00.033145 [debug] client : SerializeUniverse.cpp:102 : Universe::serialize : deserializing 30 objects 16:56:00.033145 [debug] client : SerializeUniverse.cpp:108 : Universe::serialize : deserializing 0 destroyed object ids 16:56:00.033655 [debug] client : SerializeUniverse.cpp:115 : Universe::serialize : deserializing empire known objects for 0 empires 16:56:00.033655 [debug] client : SerializeUniverse.cpp:121 : Universe::serialize : deserializing id allocator version = 1 16:56:00.033655 [debug] IDallocator : IDAllocator.cpp:271 : Deserialize IDAllocator() server id = -1 empire id = 1 16:56:00.033655 [debug] IDallocator : IDAllocator.cpp:288 : Deserialized [empire = 1 next id = 1, ] 16:56:00.033655 [debug] IDallocator : IDAllocator.cpp:271 : Deserialize IDAllocator() server id = -1 empire id = 1 16:56:00.033655 [debug] IDallocator : IDAllocator.cpp:288 : Deserialized [empire = 1 next id = 1, ] 16:56:00.034147 [debug] client : SerializeUniverse.cpp:146 : Universe::serialize : deserializing 18 types of statistic 16:56:00.034147 [debug] client : SerializeUniverse.cpp:148 : Universe::serialize : deserializing done 16:56:00.034147 [debug] client : SerializeUniverse.cpp:159 : Universe::serialize : updating empires' latest known object destruction states 16:56:00.034147 [debug] client : SerializeUniverse.cpp:167 : Universe::serialize done 16:56:00.034147 [debug] client : Message.cpp:759 : ExtractGameStartMessage universe deserialization time 2 16:56:00.034648 [debug] FSM : HumanClientFSM.cpp:733 : Extracted GameStart message for turn: 1 with empire: 1 16:56:00.034648 [debug] client : MultiplayerCommon.cpp:164 : Setting Rules from Strings: 16:56:00.034648 [debug] client : MultiplayerCommon.cpp:184 : After Setting Rules: 16:56:00.034648 [debug] client : MultiplayerCommon.cpp:186 : RULE_SHIP_HULL_COST_FACTOR : 1 16:56:00.034648 [debug] client : MultiplayerCommon.cpp:186 : RULE_STARLANES_EVERYWHERE : 0 16:56:00.035150 [debug] client : MultiplayerCommon.cpp:186 : RULE_RESEED_PRNG_SERVER : 1 16:56:00.035150 [debug] client : MultiplayerCommon.cpp:186 : RULE_CHEAP_AND_FAST_SHIP_PRODUCTION : 0 16:56:00.035150 [debug] client : MultiplayerCommon.cpp:186 : RULE_SHIP_SPEED_FACTOR : 1 16:56:00.035150 [debug] client : MultiplayerCommon.cpp:186 : RULE_SHIP_STRUCTURE_FACTOR : 1 16:56:00.035150 [debug] client : MultiplayerCommon.cpp:186 : RULE_CHEAP_AND_FAST_BUILDING_PRODUCTION : 0 16:56:00.035150 [debug] client : MultiplayerCommon.cpp:186 : RULE_NUM_COMBAT_ROUNDS : 3 16:56:00.035150 [debug] client : MultiplayerCommon.cpp:186 : RULE_CHEAP_AND_FAST_TECH_RESEARCH : 0 16:56:00.035649 [debug] client : MultiplayerCommon.cpp:186 : RULE_TEST_STRING : HUMAN_PLAYER 16:56:00.035649 [debug] client : MultiplayerCommon.cpp:186 : RULE_SHIP_PART_COST_FACTOR : 1 16:56:00.035649 [debug] client : MultiplayerCommon.cpp:186 : RULE_BUILDING_COST_FACTOR : 1 16:56:00.035649 [debug] client : MultiplayerCommon.cpp:186 : RULE_TECH_COST_FACTOR : 2 16:56:00.035649 [debug] client : MultiplayerCommon.cpp:186 : RULE_ENABLE_EXPERIMENTORS : 1 16:56:00.047668 [debug] client : ProductionWnd.cpp:1012 : ProductionWnd::UpdateQueue() 16:56:08.040551 [trace] client : Building.cpp:369 : BuildingTypeManager checksum: 8776260 16:56:08.060582 [debug] client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 16:56:09.563579 [trace] client : Special.cpp:30 : SpecialManager checksum: 8135526 16:56:09.606148 [debug] client : TechTreeWnd.cpp:1396 : Tech Tree Layout Doing Graph Layout 16:56:09.606646 [debug] client : TechTreeLayout.cpp:208 : TechTreeLayout::DoLayout creating placeholder nodes... 16:56:09.606646 [debug] client : TechTreeWnd.cpp:1403 : Tech Tree Layout Creating Panels 16:56:09.607134 [debug] client : TechTreeWnd.cpp:1438 : Tech Tree Layout Done 16:56:09.607134 [debug] client : ResearchWnd.cpp:563 : ResearchWnd::UpdateQueue() 16:56:09.626674 [debug] client : DesignWnd.cpp:665 : ShipDesignManager initializing. 16:56:09.686268 [debug] client : DesignWnd.cpp:683 : Add default designs to empire. 16:56:09.688271 [debug] client : HumanClientApp.cpp:1165 : Autosaving to: C:\Users\Owner\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Human_Player_Terran_0001_20170822_165609.sav 16:56:09.688271 [debug] client : HumanClientApp.cpp:633 : HumanClientApp::SaveGame sent save initiate message to server... 16:56:09.688759 [debug] client : MapWnd.cpp:2656 : Initializing turn 1 16:56:09.688759 [debug] client : Universe.cpp:599 : Universe::InitMeterEstimatesAndDiscrepancies 16:56:09.688759 [debug] client : Universe.cpp:606 : IMEAD: updating meter estimates 16:56:09.688759 [info] log : Logger.cpp:203 : Added logger named "effects" 16:56:09.689261 [info] log : Logger.cpp:335 : Setting "effects" logger threshold to "debug". 16:56:09.689261 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "effects" from optionsDB using threshold debug 16:56:09.752859 [trace] client : Field.cpp:256 : FieldTypeManager checksum: 8837675 16:56:09.755362 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 0 hulls/parts: 0 fields: 64 16:56:09.755362 [debug] client : Universe.cpp:1434 : Evaluation time: 64 reorder time: 0 16:56:09.755862 [info] log : Logger.cpp:203 : Added logger named "effects" 16:56:09.755862 [info] log : Logger.cpp:335 : Setting "effects" logger threshold to "debug". 16:56:09.755862 [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "effects" from optionsDB using threshold debug 16:56:09.756363 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 0 objects time: 67 ms 16:56:09.756866 [debug] client : Universe.cpp:611 : IMEAD: determining discrepancies 16:56:09.756866 [debug] client : OrderSet.cpp:32 : OrderSet::ApplyOrders() executing 0 orders 16:56:09.759369 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 0 hulls/parts: 0 fields: 0 16:56:09.759369 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:09.760370 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 0 objects time: 3468 µs 16:56:09.763374 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 1 hulls/parts: 0 fields: 0 16:56:09.763374 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:09.763876 [debug] client : MapWnd.cpp:2853 : MapWnd::InitTurnRendering 16:56:11.369591 [debug] client : MapWnd.cpp:2964 : MapWnd::InitSystemRenderingBuffers 16:56:11.396120 [debug] client : ScopedTimer.cpp:28 : MapWnd::InitSystemRenderingBuffers time: 26 ms 16:56:11.396621 [debug] client : MapWnd.cpp:3823 : MapWnd::InitStarlaneRenderingBuffers 16:56:11.481250 [debug] client : MapWnd.cpp:3863 : MapWnd::InitFieldRenderingBuffers 16:56:11.483253 [debug] client : ScopedTimer.cpp:28 : MapWnd::InitFieldRenderingBuffers time: 1909 µs 16:56:11.483253 [debug] client : MapWnd.cpp:3972 : MapWnd::InitVisibilityRadiiRenderingBuffers 16:56:11.483253 [debug] client : ScopedTimer.cpp:28 : MapWnd::InitTurnRendering time: 1719 ms 16:56:11.486758 [debug] client : MapWnd.cpp:2709 : showing intro sitreps : true 16:56:11.486758 [debug] client : SitRepPanel.cpp:725 : SitRepPanel::Update() 16:56:11.892982 [debug] client : SitRepPanel.cpp:725 : SitRepPanel::Update() 16:56:11.929540 [debug] client : MapWnd.cpp:6336 : MapWnd::RefreshResearchResourceIndicator: Showing Research Wasted Icon with RP spent: 0 and RP Production: 8.4, wasting 8.4 16:56:11.939053 [debug] client : Empire.cpp:170 : SetTechQueueElementSpending allocated: 0 of 8.4 available 16:56:11.939053 [debug] client : ResearchWnd.cpp:563 : ResearchWnd::UpdateQueue() 16:56:11.948068 [debug] client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 16:56:12.852958 [debug] client : TechTreeWnd.cpp:1396 : Tech Tree Layout Doing Graph Layout 16:56:12.852958 [debug] client : TechTreeLayout.cpp:208 : TechTreeLayout::DoLayout creating placeholder nodes... 16:56:12.852958 [debug] client : TechTreeWnd.cpp:1403 : Tech Tree Layout Creating Panels 16:56:12.853457 [debug] client : TechTreeWnd.cpp:1438 : Tech Tree Layout Done 16:56:12.873990 [debug] client : MapWnd.cpp:6336 : MapWnd::RefreshResearchResourceIndicator: Showing Research Wasted Icon with RP spent: 0 and RP Production: 8.4, wasting 8.4 16:56:12.901031 [debug] client : MapWnd.cpp:6336 : MapWnd::RefreshResearchResourceIndicator: Showing Research Wasted Icon with RP spent: 0 and RP Production: 8.4, wasting 8.4 16:56:12.910045 [debug] client : Empire.cpp:3275 : ========= Production Update for empire: 1 ======== 16:56:12.930577 [debug] client : MapWnd.cpp:6383 : MapWnd::RefreshIndustryResourceIndicator: Showing Industry Wasted Icon with Industry spent: 0 and Industry Production: 8.5, wasting 8.5 16:56:12.947102 [debug] client : ProductionWnd.cpp:1012 : ProductionWnd::UpdateQueue() 16:56:12.972641 [debug] client : MapWnd.cpp:6383 : MapWnd::RefreshIndustryResourceIndicator: Showing Industry Wasted Icon with Industry spent: 0 and Industry Production: 8.5, wasting 8.5 16:56:12.980152 [debug] client : MapWnd.cpp:3823 : MapWnd::InitStarlaneRenderingBuffers 16:56:13.000684 [debug] client : MapWnd.cpp:6383 : MapWnd::RefreshIndustryResourceIndicator: Showing Industry Wasted Icon with Industry spent: 0 and Industry Production: 8.5, wasting 8.5 16:56:13.046254 [debug] client : Empire.cpp:170 : SetTechQueueElementSpending allocated: 0 of 0 available 16:56:13.046254 [debug] client : Empire.cpp:3275 : ========= Production Update for empire: 2 ======== 16:56:13.046754 [debug] client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 16:56:13.999718 [debug] client : TechTreeWnd.cpp:1396 : Tech Tree Layout Doing Graph Layout 16:56:13.999718 [debug] client : TechTreeLayout.cpp:208 : TechTreeLayout::DoLayout creating placeholder nodes... 16:56:13.999718 [debug] client : TechTreeWnd.cpp:1403 : Tech Tree Layout Creating Panels 16:56:14.000219 [debug] client : TechTreeWnd.cpp:1438 : Tech Tree Layout Done 16:56:14.000219 [debug] client : ResearchWnd.cpp:563 : ResearchWnd::UpdateQueue() 16:56:14.017746 [debug] client : ProductionWnd.cpp:1012 : ProductionWnd::UpdateQueue() 16:56:14.029763 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 0 hulls/parts: 0 fields: 0 16:56:14.029763 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:14.030264 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 14 objects time: 3708 µs 16:56:14.036775 [debug] client : TechTreeWnd.cpp:1373 : Tech Tree Layout Preparing Tech Data 16:56:14.902121 [debug] client : TechTreeWnd.cpp:1396 : Tech Tree Layout Doing Graph Layout 16:56:14.902121 [debug] client : TechTreeLayout.cpp:208 : TechTreeLayout::DoLayout creating placeholder nodes... 16:56:14.902121 [debug] client : TechTreeWnd.cpp:1403 : Tech Tree Layout Creating Panels 16:56:14.902623 [debug] client : TechTreeWnd.cpp:1438 : Tech Tree Layout Done 16:56:14.902623 [debug] client : TechTreeWnd.cpp:1831 : Tech List Box Populating 16:56:18.134584 [debug] client : TechTreeWnd.cpp:1883 : Tech List Box Done Populating 16:56:18.135085 [debug] client : TechTreeWnd.cpp:1884 : Creation time=2670ms 16:56:18.135085 [debug] client : TechTreeWnd.cpp:1885 : Insertion time=0ms 16:56:18.135085 [debug] client : ResearchWnd.cpp:563 : ResearchWnd::UpdateQueue() 16:56:18.154115 [debug] client : MapWnd.cpp:6383 : MapWnd::RefreshIndustryResourceIndicator: Showing Industry Wasted Icon with Industry spent: 0 and Industry Production: 8.5, wasting 8.5 16:56:18.177150 [debug] client : MapWnd.cpp:6336 : MapWnd::RefreshResearchResourceIndicator: Showing Research Wasted Icon with RP spent: 0 and RP Production: 8.4, wasting 8.4 16:56:18.212204 [debug] client : MapWnd.cpp:6907 : MapWnd::DispatchFleetsExploring called 16:56:18.215709 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - meter estimates time: 74 ms 16:56:18.216210 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - rendering time: 1719 ms 16:56:18.216210 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - fleet signals time: 3265 µs 16:56:18.216210 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - sitreps time: 420 ms 16:56:18.216210 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - update resource pools time: 1139 ms 16:56:18.216210 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - refresh research time: 963 ms 16:56:18.216210 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - refresh production wnd time: 4129 ms 16:56:18.216711 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - refresh indicators time: 73 ms 16:56:18.216711 [debug] client : ScopedTimer.cpp:168 : MapWnd::InitTurn - enable observers time: 3389 µs 16:56:18.216711 [debug] client : ScopedTimer.cpp:178 : MapWnd::InitTurn time: 8527 ms 16:56:18.588781 [debug] client : ScopedTimer.cpp:28 : SidePanel::RefreshImpl time: 345 ms 16:56:18.744020 [debug] client : ScopedTimer.cpp:28 : SidePanel::RefreshImpl time: 154 ms 16:56:18.898257 [debug] client : ScopedTimer.cpp:28 : GetRotatingPlanetData time: 2752 µs 16:56:18.921793 [debug] client : ScopedTimer.cpp:28 : RotatingPlanetControl::Refresh time: 26 ms 16:56:18.926300 [debug] client : ScopedTimer.cpp:28 : RotatingPlanetControl::Refresh time: 3014 µs 16:56:18.982887 [debug] FSM : HumanClientFSM.cpp:877 : Sending Save Game Data to Server 16:56:22.979614 [debug] client : ProductionWnd.cpp:1012 : ProductionWnd::UpdateQueue() 16:56:24.150903 [debug] client : ProductionWnd.cpp:1012 : ProductionWnd::UpdateQueue() 16:56:25.282140 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 0 hulls/parts: 0 fields: 0 16:56:25.282140 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:25.283143 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 14 objects time: 3638 µs 16:56:26.603366 [debug] client : HumanClientApp.cpp:637 : HumanClientApp::SaveGameCompleted by server. 16:56:29.996194 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 1 techs: 0 buildings: 0 hulls/parts: 0 fields: 0 16:56:29.996194 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:29.997208 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 14 objects time: 3167 µs 16:56:30.001202 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 1 hulls/parts: 0 fields: 0 16:56:30.001202 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:30.001702 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 14 objects time: 3000 µs 16:56:30.010216 [debug] client : ProductionWnd.cpp:1012 : ProductionWnd::UpdateQueue() 16:56:30.585002 [debug] client : ProductionWnd.cpp:1012 : ProductionWnd::UpdateQueue() 16:56:31.159875 [debug] client : ScopedTimer.cpp:28 : RotatingPlanetControl::Refresh time: 1426 µs 16:56:31.161377 [debug] client : ScopedTimer.cpp:28 : RotatingPlanetControl::Refresh time: 1471 µs 16:56:31.228981 [debug] client : ScopedTimer.cpp:28 : RotatingPlanetControl::Refresh time: 1438 µs 16:56:37.640440 [debug] client : EncyclopediaDetailPanel.cpp:2162 : default enemy stats:: tech_level: 0.0025 DR: 0.05 attack: 3.0675 16:56:37.649953 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 0 hulls/parts: 1 fields: 0 16:56:37.649953 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:37.650454 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 1 objects time: 3786 µs 16:56:37.655439 [debug] client : Universe.cpp:1427 : Issue times: planet species: 0 ship species: 0 specials: 0 techs: 0 buildings: 1 hulls/parts: 0 fields: 0 16:56:37.655532 [debug] client : Universe.cpp:1434 : Evaluation time: 1 reorder time: 0 16:56:37.656130 [debug] client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 1 objects time: 3636 µs 16:56:37.659300 [debug] client : Universe.cpp:2742 : Universe::Delete with ID: -2