Game stalling (0.4.7.1)

Problems and solutions for installing or running FreeOrion, including discussion of bugs if needed before posting a bug report on GitHub. For problems building from source, post in Compile.

Moderator: Oberlus

Post Reply
Message
Author
PrVonTuckIII
Space Krill
Posts: 6
Joined: Thu Jan 24, 2019 6:06 pm

Game stalling (0.4.7.1)

#1 Post by PrVonTuckIII »

So I recently posted a topic about the connection being lost, which seems to have fixed itself. However, the game seems to be experiencing... well I guess a stall is the best word for it. I can load a game, and I can select ships, give move orders, etc, but I can't progress turns (clicking the button does nothing, nor does trying to exit by closing the main game window). The game runs terribly slowly (5-10 FPS), and going by what Task Manager is telling me, taking up all of my CPU. Another minor thing I noticed was that the AI empires don't submit their moves at all.

freeorion:

Code: Select all

2019-01-26 15:16:29.922019 [debug] Client : Logger.cpp:67 : Logger initialized
2019-01-26 15:16:29.923050 [info] Client : Logger.cpp:68 : v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015
2019-01-26 15:16:29.923050 [info] Client : HumanClientApp.cpp:214 : GL Version String: 4.5.0 - Build 24.20.100.6025
2019-01-26 15:16:29.923050 [info] Client : DependencyVersions.cpp:81 : Dependency versions from headers:
2019-01-26 15:16:29.923050 [info] Client : DependencyVersions.cpp:84 : Boost: 1_59
2019-01-26 15:16:29.924004 [info] Client : DependencyVersions.cpp:84 : FreeType: 2.5.5
2019-01-26 15:16:29.924004 [info] Client : DependencyVersions.cpp:84 : PNG: 1.6.29
2019-01-26 15:16:29.924004 [info] Client : DependencyVersions.cpp:84 : SDL: 2.0.4
2019-01-26 15:16:29.924004 [info] Client : DependencyVersions.cpp:84 : libvorbis: Xiph.Org libVorbis 1.3.5
2019-01-26 15:16:29.924004 [info] Client : DependencyVersions.cpp:84 : zlib: 1.2.8
2019-01-26 15:16:30.896506 [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

2019-01-26 15:16:30.896506 [debug] Client : Sound.cpp:252 : Audio enabled.
2019-01-26 15:16:30.897504 [error] Client : Sound.cpp:462 : PlayMusic: unable to open file C:\Program Files (x86)\FreeOrion\default\data\sound\artificial_intelligence_v3.ogg I/O Error. Aborting

2019-01-26 15:16:30.897504 [debug] Client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_DOWN' for hotkey map.pan_down
2019-01-26 15:16:30.897504 [debug] Client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_LEFT' for hotkey map.pan_left
2019-01-26 15:16:30.897504 [debug] Client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_RIGHT' for hotkey map.pan_right
2019-01-26 15:16:30.897504 [debug] Client : Hotkeys.cpp:218 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_UP' for hotkey map.pan_up
2019-01-26 15:16:30.944389 [error] Client : StringTable.cpp:48 : StringTable_::Load failed to read file at path: C:\Program Files (x86)\FreeOrion\default\stringtables\en.txt
2019-01-26 15:16:30.947339 [debug] Client : ClientUI.cpp:436 : loading 0 charsets for current stringtable characters
2019-01-26 15:16:30.947339 [debug] Client : ClientUI.cpp:440 : Non-default stringtable!
2019-01-26 15:16:30.967326 [debug] Client : ClientUI.cpp:451 : loading 14 charsets for default stringtable characters
2019-01-26 15:16:30.967326 [debug] Client : ClientUI.cpp:454 : combined stringtable charsets have 14 charsets
2019-01-26 15:16:30.967326 [debug] Client : ClientUI.cpp:465 : 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, 
2019-01-26 15:16:31.240245 [debug] Client : HumanClientApp.cpp:1193 : Limited FPS to 60
2019-01-26 15:16:31.241237 [debug] Client : HumanClientApp.cpp:158 : OpenGL Version Number: 4.5
2019-01-26 15:16:31.288112 [debug] Client : HumanClientFSM.cpp:110 : (HumanClientFSM) IntroMenu
2019-01-26 15:16:31.288112 [debug] Client : HumanClientApp.cpp:908 : HumanClientApp::HandleFocusChange(Gained Focus)
2019-01-26 15:16:32.703840 [debug] Client : DesignWnd.cpp:1584 : BasesListBox::Populate
2019-01-26 15:16:32.703840 [debug] Client : DesignWnd.cpp:1748 : BasesListBox::PopulateWithSavedDesigns
2019-01-26 15:16:33.051659 [debug] Client : DesignWnd.cpp:2847 : DesignWnd::MainPanel::ReregisterDesigns
2019-01-26 15:16:34.516465 [debug] Client : HumanClientApp.cpp:600 : HumanClientApp::LoadSinglePlayerGame
2019-01-26 15:16:34.519456 [debug] Client : SaveFileDialog.cpp:671 : pathstring: C:\Users\Sai\AppData\Roaming\FreeOrion\save
2019-01-26 15:16:34.519456 [debug] Client : SaveFileDialog.cpp:930 : SaveFileDialog::UpdatePreviewList
2019-01-26 15:16:34.527435 [debug] Client : SaveFileDialog.cpp:597 : SaveFileDialog::FilterColumns: Visible columns: 5
2019-01-26 15:16:34.529429 [debug] Client : SaveFileDialog.cpp:554 : SaveFileDialog::LoadDirectories name: auto valid UTF-8: true
2019-01-26 15:16:34.707804 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\665.sav
2019-01-26 15:16:34.707804 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.707804 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\665.sav
2019-01-26 15:16:34.707804 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\Game 1 Save 1 - Sol Confederacy.sav
2019-01-26 15:16:34.708833 [debug] Client : SaveGamePreviewUtils.cpp:82 : Deserializing XML data
2019-01-26 15:16:34.708833 [error] Client : SaveGamePreviewUtils.cpp:91 : LoadSaveGamePreviewData: Failed to read preview of C:\Users\Sai\AppData\Roaming\FreeOrion\save\Game 1 Save 1 - Sol Confederacy.sav because: unrecognized XML syntax
2019-01-26 15:16:34.742738 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 602.sav
2019-01-26 15:16:34.742738 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.743702 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 602.sav
2019-01-26 15:16:34.763957 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 612.sav
2019-01-26 15:16:34.763957 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.763957 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 612.sav
2019-01-26 15:16:34.793320 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 617.sav
2019-01-26 15:16:34.793320 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.793320 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 617.sav
2019-01-26 15:16:34.824480 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 634.sav
2019-01-26 15:16:34.824480 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.824480 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 634.sav
2019-01-26 15:16:34.858432 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 658.sav
2019-01-26 15:16:34.858432 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.858432 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 658.sav
2019-01-26 15:16:34.888215 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 665.sav
2019-01-26 15:16:34.888215 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.888215 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save 665.sav
2019-01-26 15:16:34.924654 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save.sav
2019-01-26 15:16:34.924654 [debug] Client : SaveGamePreviewUtils.cpp:82 : Deserializing XML data
2019-01-26 15:16:34.924654 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.924654 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\save.sav
2019-01-26 15:16:34.953795 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\Save2.sav
2019-01-26 15:16:34.953795 [debug] Client : SaveGamePreviewUtils.cpp:82 : Deserializing XML data
2019-01-26 15:16:34.953795 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:34.953795 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:\Users\Sai\AppData\Roaming\FreeOrion\save\Save2.sav
2019-01-26 15:16:36.472545 [debug] Client : SaveFileDialog.cpp:803 : SaveFileDialog::Confirm: Confirming
2019-01-26 15:16:36.472545 [debug] Client : SaveFileDialog.cpp:819 : choice: auto valid utf-8: true
2019-01-26 15:16:36.472545 [debug] Client : SaveFileDialog.cpp:822 : current dir PathString: C:\Users\Sai\AppData\Roaming\FreeOrion\save valid utf-8: true
2019-01-26 15:16:36.472545 [debug] Client : SaveFileDialog.cpp:825 : chosen_full_path PathString: C:\Users\Sai\AppData\Roaming\FreeOrion\save\auto valid utf-8: true
2019-01-26 15:16:36.472545 [debug] Client : SaveFileDialog.cpp:826 : chosen_full_path is directory? : true
2019-01-26 15:16:36.473542 [debug] Client : SaveFileDialog.cpp:830 : SaveFileDialog::Confirm: C:\Users\Sai\AppData\Roaming\FreeOrion\save\auto is a directory. Listing content.
2019-01-26 15:16:36.473542 [debug] Client : SaveFileDialog.cpp:930 : SaveFileDialog::UpdatePreviewList
2019-01-26 15:16:36.479531 [debug] Client : SaveFileDialog.cpp:597 : SaveFileDialog::FilterColumns: Visible columns: 5
2019-01-26 15:16:36.645763 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0670_20190123_111626.sav
2019-01-26 15:16:36.645763 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:36.645763 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0670_20190123_111626.sav
2019-01-26 15:16:36.679389 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0680_20190123_222716.sav
2019-01-26 15:16:36.679389 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:36.679389 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0680_20190123_222716.sav
2019-01-26 15:16:36.717734 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0681_20190125_095106.sav
2019-01-26 15:16:36.717734 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:36.717734 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0681_20190125_095106.sav
2019-01-26 15:16:36.750023 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0682_20190125_100240.sav
2019-01-26 15:16:36.751021 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:36.751021 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0682_20190125_100240.sav
2019-01-26 15:16:36.783276 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0685_20190125_104509.sav
2019-01-26 15:16:36.784239 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:36.784239 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0685_20190125_104509.sav
2019-01-26 15:16:36.788260 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0690_20190125_122600.sav
2019-01-26 15:16:36.788260 [debug] Client : SaveGamePreviewUtils.cpp:88 : Loaded preview with: 1 human players
2019-01-26 15:16:36.788260 [debug] Client : SaveGamePreviewUtils.cpp:96 : LoadSaveGamePreviewData: Successfully loaded preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0690_20190125_122600.sav
2019-01-26 15:16:36.806261 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_204700.sav
2019-01-26 15:16:36.807227 [debug] Client : SaveGamePreviewUtils.cpp:82 : Deserializing XML data
2019-01-26 15:16:36.807227 [error] Client : SaveGamePreviewUtils.cpp:91 : LoadSaveGamePreviewData: Failed to read preview of C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_204700.sav because: input stream error
2019-01-26 15:16:36.819195 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_205007.sav
2019-01-26 15:16:36.819195 [debug] Client : SaveGamePreviewUtils.cpp:82 : Deserializing XML data
2019-01-26 15:16:36.820226 [error] Client : SaveGamePreviewUtils.cpp:91 : LoadSaveGamePreviewData: Failed to read preview of C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_205007.sav because: input stream error
2019-01-26 15:16:36.833284 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_205121.sav
2019-01-26 15:16:36.833284 [debug] Client : SaveGamePreviewUtils.cpp:82 : Deserializing XML data
2019-01-26 15:16:36.834312 [error] Client : SaveGamePreviewUtils.cpp:91 : LoadSaveGamePreviewData: Failed to read preview of C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_205121.sav because: input stream error
2019-01-26 15:16:36.845740 [debug] Client : SaveGamePreviewUtils.cpp:65 : LoadSaveGamePreviewData: Loading preview from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_205602.sav
2019-01-26 15:16:36.845740 [debug] Client : SaveGamePreviewUtils.cpp:82 : Deserializing XML data
2019-01-26 15:16:36.845740 [error] Client : SaveGamePreviewUtils.cpp:91 : LoadSaveGamePreviewData: Failed to read preview of C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion__Observer_0664_20190118_205602.sav because: input stream error
2019-01-26 15:16:37.874730 [debug] Client : SaveFileDialog.cpp:803 : SaveFileDialog::Confirm: Confirming
2019-01-26 15:16:37.875729 [debug] Client : SaveFileDialog.cpp:819 : choice: FreeOrion_Professor_Sol_0690_20190125_122600.sav valid utf-8: true
2019-01-26 15:16:37.875729 [debug] Client : SaveFileDialog.cpp:822 : current dir PathString: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto valid utf-8: true
2019-01-26 15:16:37.875729 [debug] Client : SaveFileDialog.cpp:825 : chosen_full_path PathString: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0690_20190125_122600.sav valid utf-8: true
2019-01-26 15:16:37.875729 [debug] Client : SaveFileDialog.cpp:826 : chosen_full_path is directory? : false
2019-01-26 15:16:37.891686 [debug] Client : HumanClientApp.cpp:632 : HumanClientApp::LoadSinglePlayerGame() not already in a game, so don't need to end it
2019-01-26 15:16:37.891686 [debug] Client : HumanClientApp.cpp:637 : HumanClientApp::LoadSinglePlayerGame() Starting server
2019-01-26 15:16:37.891686 [debug] Client : HumanClientApp.cpp:377 : HumanClientApp::StartServer: C:\Program Files (x86)\FreeOrionA\freeoriond.exe
2019-01-26 15:16:37.891686 [debug] Client : HumanClientApp.cpp:407 : ai-config not set.
2019-01-26 15:16:37.897668 [debug] Client : HumanClientApp.cpp:639 : HumanClientApp::LoadSinglePlayerGame() Server started
2019-01-26 15:16:37.897668 [debug] Client : HumanClientApp.cpp:644 : HumanClientApp::LoadSinglePlayerGame() Connecting to server
2019-01-26 15:16:37.897668 [debug] Client : ClientNetworking.cpp:317 : Attempt to connect to server at one of these addresses:
2019-01-26 15:16:37.898666 [debug] Client : ClientNetworking.cpp:319 :   tcp::resolver::iterator host_name: 127.0.0.1  address: 127.0.0.1  port: 12346
2019-01-26 15:16:38.399630 [debug] Client : ClientNetworking.cpp:338 : Connected to server at host_name: 127.0.0.1  address: 127.0.0.1  port: 12346
2019-01-26 15:16:38.399630 [debug] Client : ClientNetworking.cpp:362 : Connecting to server took 501 ms.
2019-01-26 15:16:38.399630 [debug] Client : ClientNetworking.cpp:365 : ConnectToServer() : starting networking thread
2019-01-26 15:16:38.399630 [debug] Client : ClientNetworking.cpp:422 : ClientNetworking::SetPlayerID: player id set to: -1
2019-01-26 15:16:38.400631 [debug] Client : HumanClientFSM.cpp:119 : (HumanClientFSM) IntroMenu.HostSPGameRequested
2019-01-26 15:16:38.400631 [debug] Client : HumanClientFSM.cpp:115 : (HumanClientFSM) ~IntroMenu
2019-01-26 15:16:38.400631 [debug] Client : HumanClientFSM.cpp:147 : (HumanClientFSM) WaitingForSPHostAck
2019-01-26 15:16:38.469488 [debug] Client : HumanClientFSM.cpp:153 : (HumanClientFSM) WaitingForSPHostAck.HostSPGame
2019-01-26 15:16:38.469488 [debug] Client : ClientNetworking.cpp:422 : ClientNetworking::SetPlayerID: player id set to: 1
2019-01-26 15:16:38.482419 [debug] Client : SitRepPanel.cpp:731 : SitRepPanel::Update()
2019-01-26 15:16:38.487400 [debug] Client : DesignWnd.cpp:2847 : DesignWnd::MainPanel::ReregisterDesigns
2019-01-26 15:16:38.487400 [debug] Client : HumanClientFSM.cpp:150 : (HumanClientFSM) ~WaitingForSPHostAck
2019-01-26 15:16:38.487400 [debug] Client : HumanClientFSM.cpp:449 : (HumanClientFSM) PlayingGame
2019-01-26 15:16:38.487400 [debug] Client : HumanClientFSM.cpp:615 : (HumanClientFSM) WaitingForGameStart
2019-01-26 15:16:38.492386 [debug] Client : HumanClientFSM.cpp:589 : (HumanClientFSM) PlayingGame.TurnProgress
2019-01-26 15:16:39.992952 [debug] Client : HumanClientApp.cpp:908 : HumanClientApp::HandleFocusChange(Lost Focus)
2019-01-26 15:16:47.640508 [debug] Client : HumanClientFSM.cpp:589 : (HumanClientFSM) PlayingGame.TurnProgress
2019-01-26 15:17:00.462128 [debug] Client : HumanClientFSM.cpp:627 : (HumanClientFSM) WaitingForGameStart.GameStart
2019-01-26 15:17:03.190846 [debug] Client : Message.cpp:728 : ExtractGameStartMessage empire deserialization time 59
2019-01-26 15:17:03.198825 [debug] Client : SerializeUniverse.cpp:70 : Universe::serialize : deserializing universe width: 2589.08
2019-01-26 15:17:03.204809 [debug] Client : SerializeUniverse.cpp:75 : Universe::serialize : deserializing 0 ship designs
2019-01-26 15:17:03.285593 [debug] Client : SerializeUniverse.cpp:83 : Universe::serialize : deserializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:03.684526 [debug] Client : SerializeUniverse.cpp:96 : Universe::serialize : deserializing 16458 objects
2019-01-26 15:17:03.685524 [debug] Client : SerializeUniverse.cpp:102 : Universe::serialize : deserializing 3246 destroyed object ids
2019-01-26 15:17:03.699486 [debug] Client : SerializeUniverse.cpp:109 : Universe::serialize : deserializing empire known objects for 0 empires
2019-01-26 15:17:03.699486 [debug] Client : SerializeUniverse.cpp:114 : Universe::serialize : deserializing last allocated ids
2019-01-26 15:17:03.975747 [debug] Client : SerializeUniverse.cpp:118 : Universe::serialize : deserializing 18 types of statistic
2019-01-26 15:17:03.975747 [debug] Client : SerializeUniverse.cpp:120 : Universe::serialize : deserializing done
2019-01-26 15:17:03.975747 [debug] Client : SerializeUniverse.cpp:131 : Universe::serialize : updating empires' latest known object destruction states
2019-01-26 15:17:03.975747 [debug] Client : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:03.975747 [debug] Client : Message.cpp:736 : ExtractGameStartMessage universe deserialization time 776
2019-01-26 15:17:03.980734 [debug] Client : HumanClientFSM.cpp:647 : Extracted GameStart message for turn: 690 with empire: 1
2019-01-26 15:17:03.984723 [debug] Client : ProductionWnd.cpp:988 : ProductionWnd::UpdateQueue()
2019-01-26 15:17:06.222739 [debug] Client : TechTreeWnd.cpp:1359 : Tech Tree Layout Preparing Tech Data
2019-01-26 15:17:09.969256 [debug] Client : TechTreeWnd.cpp:1382 : Tech Tree Layout Doing Graph Layout
2019-01-26 15:17:09.969256 [debug] Client : TechTreeLayout.cpp:208 : TechTreeLayout::DoLayout creating placeholder nodes...
2019-01-26 15:17:09.972247 [debug] Client : TechTreeWnd.cpp:1389 : Tech Tree Layout Creating Panels
2019-01-26 15:17:09.976235 [debug] Client : TechTreeWnd.cpp:1421 : Tech Tree Layout Done
2019-01-26 15:17:09.976235 [debug] Client : ResearchWnd.cpp:564 : ResearchWnd::UpdateQueue()
2019-01-26 15:17:10.007831 [debug] Client : HumanClientFSM.cpp:624 : (HumanClientFSM) ~WaitingForGameStart
2019-01-26 15:17:10.008828 [debug] Client : HumanClientFSM.cpp:744 : (HumanClientFSM) PlayingTurn
2019-01-26 15:17:10.008828 [debug] Client : MapWnd.cpp:2588 : Initializing turn 690
2019-01-26 15:17:10.017119 [debug] Client : Universe.cpp:540 : Universe::InitMeterEstimatesAndDiscrepancies
2019-01-26 15:17:10.017119 [debug] Client : Universe.cpp:547 : IMEAD: updating meter estimates
2019-01-26 15:17:12.532940 [error] Client : ValueRef.cpp:83 : FollowReference : Unable to get system for object
2019-01-26 15:17:12.532940 [error] Client : ValueRef.cpp:776 : Variable<int>::Eval unable to follow reference: LocalCandidate.System.LastTurnBattleHere :  | Local Candidate: Ship 88413 (  )  |  System (-1):  |  LastTurnBattleHere  | 
2019-01-26 15:17:12.537923 [error] Client : ValueRef.cpp:778 : source: OBJ_PLANET 2151 ( Homeworld Lir β I ) 
2019-01-26 15:17:12.537923 [error] Client : ValueRef.cpp:83 : FollowReference : Unable to get system for object
2019-01-26 15:17:12.537923 [error] Client : ValueRef.cpp:776 : Variable<int>::Eval unable to follow reference: LocalCandidate.System.LastTurnBattleHere :  | Local Candidate: Ship 88560 (  )  |  System (-1):  |  LastTurnBattleHere  | 
2019-01-26 15:17:12.538919 [error] Client : ValueRef.cpp:778 : source: OBJ_PLANET 2151 ( Homeworld Lir β I ) 
2019-01-26 15:17:17.199566 [debug] Client : Universe.cpp:1380 : Issue times: planet species: 1 ship species: 4 specials: 7 techs: 68 buildings: 2 hulls/parts: 28 fields: 170
2019-01-26 15:17:17.199566 [debug] Client : Universe.cpp:1387 : Evaluation time: 6937 reorder time: 78
2019-01-26 15:17:18.111129 [debug] Client : ScopedTimer.cpp:28 : Universe::ExecuteEffects time:      654 ms
2019-01-26 15:17:18.141060 [debug] Client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 0 objects time:     8116 ms
2019-01-26 15:17:18.141060 [debug] Client : Universe.cpp:552 : IMEAD: determining discrepancies
2019-01-26 15:17:18.150025 [debug] Client : OrderSet.cpp:28 : OrderSet::ApplyOrders() executing 0 orders
2019-01-26 15:17:21.684698 [error] Client : ValueRef.cpp:83 : FollowReference : Unable to get system for object
2019-01-26 15:17:21.684698 [error] Client : ValueRef.cpp:776 : Variable<int>::Eval unable to follow reference: LocalCandidate.System.LastTurnBattleHere :  | Local Candidate: Ship 88413 (  )  |  System (-1):  |  LastTurnBattleHere  | 
2019-01-26 15:17:21.687681 [error] Client : ValueRef.cpp:778 : source: OBJ_PLANET 2151 ( Homeworld Lir β I ) 
2019-01-26 15:17:21.687681 [error] Client : ValueRef.cpp:83 : FollowReference : Unable to get system for object
2019-01-26 15:17:21.687681 [error] Client : ValueRef.cpp:776 : Variable<int>::Eval unable to follow reference: LocalCandidate.System.LastTurnBattleHere :  | Local Candidate: Ship 88560 (  )  |  System (-1):  |  LastTurnBattleHere  | 
2019-01-26 15:17:21.688715 [error] Client : ValueRef.cpp:778 : source: OBJ_PLANET 2151 ( Homeworld Lir β I ) 
2019-01-26 15:17:25.154018 [debug] Client : Universe.cpp:1380 : Issue times: planet species: 1 ship species: 5 specials: 9 techs: 69 buildings: 2 hulls/parts: 28 fields: 0
2019-01-26 15:17:25.154018 [debug] Client : Universe.cpp:1387 : Evaluation time: 6732 reorder time: 80
2019-01-26 15:17:26.079544 [debug] Client : ScopedTimer.cpp:28 : Universe::ExecuteEffects time:      667 ms
2019-01-26 15:17:26.127416 [debug] Client : ScopedTimer.cpp:28 : Universe::UpdateMeterEstimatesImpl on 0 objects time:     7943 ms
2019-01-26 15:17:27.696731 [error] Client : ValueRef.cpp:83 : FollowReference : Unable to get system for object
2019-01-26 15:17:27.696731 [error] Client : ValueRef.cpp:776 : Variable<int>::Eval unable to follow reference: LocalCandidate.System.LastTurnBattleHere :  | Local Candidate: Ship 88413 (  )  |  System (-1):  |  LastTurnBattleHere  | 
2019-01-26 15:17:27.710694 [error] Client : ValueRef.cpp:778 : source: OBJ_PLANET 2151 ( Homeworld Lir β I ) 
2019-01-26 15:17:27.710694 [error] Client : ValueRef.cpp:83 : FollowReference : Unable to get system for object
2019-01-26 15:17:27.710694 [error] Client : ValueRef.cpp:776 : Variable<int>::Eval unable to follow reference: LocalCandidate.System.LastTurnBattleHere :  | Local Candidate: Ship 88560 (  )  |  System (-1):  |  LastTurnBattleHere  | 
2019-01-26 15:17:27.710694 [error] Client : ValueRef.cpp:778 : source: OBJ_PLANET 2151 ( Homeworld Lir β I ) 
2019-01-26 15:17:32.278992 [debug] Client : Universe.cpp:1380 : Issue times: planet species: 0 ship species: 5 specials: 9 techs: 76 buildings: 2 hulls/parts: 28 fields: 0
2019-01-26 15:17:32.278992 [debug] Client : Universe.cpp:1387 : Evaluation time: 5938 reorder time: 69
2019-01-26 15:17:32.567221 [debug] Client : ScopedTimer.cpp:28 : Universe::ExecuteEffects time:       74 ms
2019-01-26 15:17:32.588165 [debug] Client : MapWnd.cpp:2777 : MapWnd::InitTurnRendering
2019-01-26 15:17:34.539946 [debug] Client : MapWnd.cpp:2882 : MapWnd::InitSystemRenderingBuffers
2019-01-26 15:17:34.804241 [debug] Client : ScopedTimer.cpp:28 : MapWnd::InitSystemRenderingBuffers time:      264 ms
2019-01-26 15:17:34.805238 [debug] Client : MapWnd.cpp:3740 : MapWnd::InitStarlaneRenderingBuffers
2019-01-26 15:17:34.837153 [debug] Client : ScopedTimer.cpp:28 : MapWnd::InitStarlaneRenderingBuffers time:       32 ms
2019-01-26 15:17:37.147974 [debug] Client : MapWnd.cpp:3778 : MapWnd::InitFieldRenderingBuffers
2019-01-26 15:17:37.149969 [debug] Client : ScopedTimer.cpp:28 : MapWnd::InitFieldRenderingBuffers time:     1443 µs
2019-01-26 15:17:37.149969 [debug] Client : MapWnd.cpp:3886 : MapWnd::InitVisibilityRadiiRenderingBuffers
2019-01-26 15:17:37.166926 [debug] Client : ScopedTimer.cpp:28 : MapWnd::InitVisibilityRadiiRenderingBuffers time:       17 ms
2019-01-26 15:17:37.168919 [debug] Client : ScopedTimer.cpp:28 : MapWnd::InitTurnRendering time:     4580 ms
2019-01-26 15:17:37.191857 [debug] Client : ScopedTimer.cpp:28 : AddFleetsStateChangedSignal() time:       17 ms
2019-01-26 15:17:37.192855 [debug] Client : ScopedTimer.cpp:28 : RefreshFleetSignals() time:       19 ms
2019-01-26 15:17:37.193852 [debug] Client : MapWnd.cpp:2641 : showing intro sitreps : false
2019-01-26 15:17:43.567322 [debug] Client : SitRepPanel.cpp:731 : SitRepPanel::Update()
2019-01-26 15:17:43.752827 [debug] Client : SitRepPanel.cpp:731 : SitRepPanel::Update()
2019-01-26 15:17:43.851562 [debug] Client : ResearchWnd.cpp:564 : ResearchWnd::UpdateQueue()
2019-01-26 15:17:43.858544 [debug] Client : TechTreeWnd.cpp:1359 : Tech Tree Layout Preparing Tech Data
2019-01-26 15:17:45.064320 [debug] Client : TechTreeWnd.cpp:1382 : Tech Tree Layout Doing Graph Layout
2019-01-26 15:17:45.064320 [debug] Client : TechTreeLayout.cpp:208 : TechTreeLayout::DoLayout creating placeholder nodes...
2019-01-26 15:17:45.067312 [debug] Client : TechTreeWnd.cpp:1389 : Tech Tree Layout Creating Panels
2019-01-26 15:17:45.071301 [debug] Client : TechTreeWnd.cpp:1421 : Tech Tree Layout Done
2019-01-26 15:17:45.082272 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 1 ========
2019-01-26 15:17:45.372497 [debug] Client : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:17:45.830272 [debug] Client : Empire.cpp:1258 : ProductionQueue::Update: Projections took 181514 microseconds with 1589.7 total Production Points
2019-01-26 15:17:45.832266 [debug] Client : ProductionWnd.cpp:988 : ProductionWnd::UpdateQueue()
2019-01-26 15:17:45.840245 [debug] Client : MapWnd.cpp:3740 : MapWnd::InitStarlaneRenderingBuffers
2019-01-26 15:17:45.866176 [debug] Client : ScopedTimer.cpp:28 : MapWnd::InitStarlaneRenderingBuffers time:       26 ms
2019-01-26 15:17:45.964912 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 2 ========
2019-01-26 15:17:46.012785 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.012785 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 3 ========
2019-01-26 15:17:46.012785 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.012785 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 4 ========
2019-01-26 15:17:46.059659 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.060656 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 5 ========
2019-01-26 15:17:46.117505 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.118503 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 6 ========
2019-01-26 15:17:46.118503 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.118503 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 7 ========
2019-01-26 15:17:46.162384 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.162384 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 8 ========
2019-01-26 15:17:46.205269 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.205269 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 9 ========
2019-01-26 15:17:46.290042 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.291040 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 10 ========
2019-01-26 15:17:46.291040 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.291040 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 11 ========
2019-01-26 15:17:46.291040 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.291040 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 12 ========
2019-01-26 15:17:46.382795 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.383792 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 13 ========
2019-01-26 15:17:46.428672 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.428672 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 14 ========
2019-01-26 15:17:46.428672 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.429669 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 15 ========
2019-01-26 15:17:46.475548 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.475548 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 16 ========
2019-01-26 15:17:46.475548 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.476545 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 17 ========
2019-01-26 15:17:46.537381 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.538378 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 18 ========
2019-01-26 15:17:46.538378 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.557328 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 19 ========
2019-01-26 15:17:46.557328 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.557328 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 20 ========
2019-01-26 15:17:46.557328 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.558325 [debug] Client : Empire.cpp:3369 : ========= Production Update for empire: 21 ========
2019-01-26 15:17:46.558325 [debug] Client : Empire.cpp:1031 : not enough PP to be worth simulating future turns production.  marking everything as never complete
2019-01-26 15:17:46.561318 [debug] Client : TechTreeWnd.cpp:1359 : Tech Tree Layout Preparing Tech Data
2019-01-26 15:17:47.731190 [debug] Client : TechTreeWnd.cpp:1382 : Tech Tree Layout Doing Graph Layout
2019-01-26 15:17:47.731190 [debug] Client : TechTreeLayout.cpp:208 : TechTreeLayout::DoLayout creating placeholder nodes...
2019-01-26 15:17:47.734182 [debug] Client : TechTreeWnd.cpp:1389 : Tech Tree Layout Creating Panels
2019-01-26 15:17:47.737174 [debug] Client : TechTreeWnd.cpp:1421 : Tech Tree Layout Done
2019-01-26 15:17:47.737174 [debug] Client : ResearchWnd.cpp:564 : ResearchWnd::UpdateQueue()
2019-01-26 15:17:47.740166 [debug] Client : ProductionWnd.cpp:988 : ProductionWnd::UpdateQueue()
2019-01-26 15:17:47.774076 [debug] Client : MapWnd.cpp:6851 : MapWnd::DispatchFleetsExploring called
2019-01-26 15:17:47.775073 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - system graph           time:     8611 µs
2019-01-26 15:17:47.775073 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - meter estimates        time:    22571 ms
2019-01-26 15:17:47.775073 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - rendering              time:     4580 ms
2019-01-26 15:17:47.775073 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - fleet signals          time:       24 ms
2019-01-26 15:17:47.776081 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - sitreps                time:     6592 ms
2019-01-26 15:17:47.776081 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - update resource pools  time:     2772 ms
2019-01-26 15:17:47.776081 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - refresh research       time:     1181 ms
2019-01-26 15:17:47.776081 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - refresh production wnd time:     3864 µs
2019-01-26 15:17:47.776081 [debug] Client : ScopedTimer.cpp:168 : MapWnd::InitTurn - refresh indicators     time:       30 ms
2019-01-26 15:17:47.776081 [debug] Client : ScopedTimer.cpp:178 : MapWnd::InitTurn                          time:    37766 ms
2019-01-26 15:17:55.561427 [debug] Client : HumanClientFSM.cpp:879 : (PlayerFSM) PlayingGame::DispatchCombatLogs message received
2019-01-26 15:17:55.561427 [debug] Client : HumanClientApp.cpp:856 : HCL Update Combat Logs
2019-01-26 15:17:55.935447 [debug] Client : HumanClientFSM.cpp:790 : (HumanClientFSM) ~PlayingTurn
2019-01-26 15:17:55.935447 [debug] Client : HumanClientFSM.cpp:457 : (HumanClientFSM) ~PlayingGame
2019-01-26 15:17:55.959382 [error] Client : HumanClientApp.cpp:805 : exception handing message: bad allocation
2019-01-26 15:17:55.959382 [error] Client : HumanClientApp.cpp:806 : message type: UNDEFINED and text: 
2019-01-26 15:18:19.785863 [error] Client : HumanClientFSM.cpp:99 : HumanClientFSM : A PlayerStatus event was passed to the HumanClientFSM.  This event is illegal in the FSM's current state.  It is being ignored.
2019-01-26 15:18:30.868777 [debug] Client : HumanClientApp.cpp:908 : HumanClientApp::HandleFocusChange(Gained Focus)
2019-01-26 15:18:36.934162 [error] Client : HumanClientFSM.cpp:99 : HumanClientFSM : A PlayerStatus event was passed to the HumanClientFSM.  This event is illegal in the FSM's current state.  It is being ignored.
2019-01-26 15:18:38.268585 [debug] Client : HumanClientApp.cpp:773 : HumanClientApp::StartTurn
2019-01-26 15:18:38.269581 [debug] Client : HumanClientApp.cpp:781 : Current Output (turn 690) RP/PP: 1.43132 (2275.37/1589.7)
2019-01-26 15:18:38.269581 [debug] Client : HumanClientApp.cpp:782 : EmpireColors: 99 63 211 255
2019-01-26 15:18:38.269581 [error] Client : HumanClientFSM.cpp:99 : HumanClientFSM : A TurnEnded event was passed to the HumanClientFSM.  This event is illegal in the FSM's current state.  It is being ignored.
2019-01-26 15:18:38.345377 [error] Client : HumanClientFSM.cpp:99 : HumanClientFSM : A PlayerStatus event was passed to the HumanClientFSM.  This event is illegal in the FSM's current state.  It is being ignored.
2019-01-26 15:18:38.402236 [error] Client : HumanClientFSM.cpp:99 : HumanClientFSM : A TurnProgress event was passed to the HumanClientFSM.  This event is illegal in the FSM's current state.  It is being ignored.
2019-01-26 15:18:41.159853 [debug] Client : HumanClientApp.cpp:939 : HumanClientApp::HandleAppQuitting()
2019-01-26 15:18:41.159853 [debug] Client : HumanClientApp.cpp:1154 : HumanClientApp::ExitApp
2019-01-26 15:18:41.159853 [error] Client : HumanClientFSM.cpp:99 : HumanClientFSM : A StartQuittingGame event was passed to the HumanClientFSM.  This event is illegal in the FSM's current state.  It is being ignored.
2019-01-26 15:18:41.159853 [debug] Client : HumanClientApp.cpp:939 : HumanClientApp::HandleAppQuitting()
2019-01-26 15:18:41.159853 [debug] Client : HumanClientApp.cpp:1154 : HumanClientApp::ExitApp
2019-01-26 15:18:41.159853 [error] Client : HumanClientFSM.cpp:99 : HumanClientFSM : A StartQuittingGame event was passed to the HumanClientFSM.  This event is illegal in the FSM's current state.  It is being ignored.
2019-01-26 15:18:44.496202 [debug] Client : HumanClientApp.cpp:908 : HumanClientApp::HandleFocusChange(Lost Focus)
I have a feeling it has something to do with the stringtables, and probably the illegal events, but I'm not sure. If it helps, one thing I noticed when checking Task manager is that the game is running over a dozen FreeOrionCA apps (no idea what it does), and sometimes an equal number of console host windows. Game is literally unplayable, as I can't go anywhere.

And before someone asks, I'd love to move over to 0.4.8, but I already have nearly 700 moves into this game, so I'd ideally like to finish this and then move over. Thanks for the help!

User avatar
Geoff the Medio
Programming, Design, Admin
Posts: 13587
Joined: Wed Oct 08, 2003 1:33 am
Location: Munich

Re: Game stalling (0.4.7.1)

#2 Post by Geoff the Medio »

There are some errors in the log relating to receiving messages from the server, eg:

Code: Select all

2019-01-26 15:17:55.959382 [error] Client : HumanClientApp.cpp:805 : exception handing message: bad allocation
It looks like communication between the client and server has stopped working, possibly due to errors allocating memory when unpacking a message from the server. Maybe something relevant will be in the server log as well, though I'm guessing it will just say the client eventually disconnected...

PrVonTuckIII
Space Krill
Posts: 6
Joined: Thu Jan 24, 2019 6:06 pm

Re: Game stalling (0.4.7.1)

#3 Post by PrVonTuckIII »

Well, if it helps, here's freeoriond:

Code: Select all

2019-01-26 15:16:38.078947 [debug] Server : Logger.cpp:67 : Logger initialized
2019-01-26 15:16:38.079944 [info] Server : Logger.cpp:68 : v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015
2019-01-26 15:16:38.079944 [info] Server : DependencyVersions.cpp:81 : Dependency versions from headers:
2019-01-26 15:16:38.079944 [info] Server : DependencyVersions.cpp:84 : Boost: 1_59
2019-01-26 15:16:38.079944 [info] Server : DependencyVersions.cpp:84 : Python: 2.7.12
2019-01-26 15:16:38.079944 [info] Server : DependencyVersions.cpp:84 : zlib: 1.2.8
2019-01-26 15:16:38.079944 [debug] Server : ServerFSM.cpp:252 : (ServerFSM) Idle
2019-01-26 15:16:38.079944 [debug] Server : ServerApp.cpp:311 : FreeOrion server waiting for network events
2019-01-26 15:16:38.399630 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:38.400631 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Host SP Game and size 1005
2019-01-26 15:16:38.400631 [debug] Server : ServerFSM.cpp:290 : (ServerFSM) Idle.HostSPGame
2019-01-26 15:16:38.465499 [error] Server : StringTable.cpp:48 : StringTable_::Load failed to read file at path: C:\Program Files (x86)\FreeOrion\default\stringtables\en.txt
2019-01-26 15:16:38.466497 [debug] Server : SaveLoad.cpp:428 : Reading player save game data from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0690_20190125_122600.sav
2019-01-26 15:16:38.466497 [debug] Server : SaveLoad.cpp:437 : Attempting binary deserialization...
2019-01-26 15:16:38.467463 [debug] Server : SaveLoad.cpp:459 : Done reading player save game data...
2019-01-26 15:16:38.467463 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 011D6808)::EstablishPlayer(1, Professor Von Tuck III, 1, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:38.467463 [debug] Server : ServerFSM.cpp:255 : (ServerFSM) ~Idle
2019-01-26 15:16:38.467463 [debug] Server : ServerFSM.cpp:1056 : (ServerFSM) WaitingForSPGameJoiners
2019-01-26 15:16:38.468481 [debug] Server : SaveLoad.cpp:428 : Reading player save game data from: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0690_20190125_122600.sav
2019-01-26 15:16:38.468481 [debug] Server : SaveLoad.cpp:437 : Attempting binary deserialization...
2019-01-26 15:16:38.468481 [debug] Server : SaveLoad.cpp:459 : Done reading player save game data...
2019-01-26 15:16:38.468481 [debug] Server : ServerApp.cpp:188 : ServerApp::CreateAIClients: 21 player (maybe not all AIs) at max aggression: 5
2019-01-26 15:16:38.469488 [debug] Server : ServerApp.cpp:337 : ServerApp::CleanupAIs() telling AIs game is ending
2019-01-26 15:16:38.469488 [debug] Server : ServerApp.cpp:357 : ServerApp::CleanupAIs() killing 0 AI clients.
2019-01-26 15:16:38.469488 [debug] Server : ServerApp.cpp:234 : starting AIs with C:\Program Files (x86)\FreeOrionA\freeorionca.exe
2019-01-26 15:16:38.469488 [debug] Server : ServerApp.cpp:235 : ai-aggression set to 5
2019-01-26 15:16:38.469488 [debug] Server : ServerApp.cpp:236 : ai-path set to 'python/AI'
2019-01-26 15:16:38.469488 [debug] Server : ServerApp.cpp:243 : ai-config not set.
2019-01-26 15:16:38.476469 [debug] Server : ServerApp.cpp:261 : done starting AI AI_4
2019-01-26 15:16:38.479421 [debug] Server : ServerApp.cpp:261 : done starting AI AI_16
2019-01-26 15:16:38.483410 [debug] Server : ServerApp.cpp:261 : done starting AI AI_5
2019-01-26 15:16:38.510338 [debug] Server : ServerApp.cpp:261 : done starting AI AI_19
2019-01-26 15:16:38.514327 [debug] Server : ServerApp.cpp:261 : done starting AI AI_1
2019-01-26 15:16:38.519316 [debug] Server : ServerApp.cpp:261 : done starting AI AI_15
2019-01-26 15:16:38.523303 [debug] Server : ServerApp.cpp:261 : done starting AI AI_14
2019-01-26 15:16:38.530284 [debug] Server : ServerApp.cpp:261 : done starting AI AI_7
2019-01-26 15:16:38.535273 [debug] Server : ServerApp.cpp:261 : done starting AI AI_8
2019-01-26 15:16:38.539261 [debug] Server : ServerApp.cpp:261 : done starting AI AI_12
2019-01-26 15:16:38.544251 [debug] Server : ServerApp.cpp:261 : done starting AI AI_11
2019-01-26 15:16:38.548237 [debug] Server : ServerApp.cpp:261 : done starting AI AI_20
2019-01-26 15:16:38.553224 [debug] Server : ServerApp.cpp:261 : done starting AI AI_3
2019-01-26 15:16:38.558220 [debug] Server : ServerApp.cpp:261 : done starting AI AI_17
2019-01-26 15:16:38.563197 [debug] Server : ServerApp.cpp:261 : done starting AI AI_6
2019-01-26 15:16:38.568184 [debug] Server : ServerApp.cpp:261 : done starting AI AI_13
2019-01-26 15:16:38.573169 [debug] Server : ServerApp.cpp:261 : done starting AI AI_18
2019-01-26 15:16:38.577160 [debug] Server : ServerApp.cpp:261 : done starting AI AI_9
2019-01-26 15:16:38.582146 [debug] Server : ServerApp.cpp:261 : done starting AI AI_10
2019-01-26 15:16:38.587133 [debug] Server : ServerApp.cpp:261 : done starting AI AI_2
2019-01-26 15:16:38.587133 [debug] Server : CommonFramework.cpp:38 : Initializing FreeOrion Python interface
2019-01-26 15:16:38.587133 [debug] Server : CommonFramework.cpp:49 : Python home set to C:\Program Files (x86)\FreeOrionA
2019-01-26 15:16:38.587133 [debug] Server : CommonFramework.cpp:52 : Python program name set to C:\Program Files (x86)\FreeOrionA\freeoriond.exe
2019-01-26 15:16:38.755264 [debug] Server : CommonFramework.cpp:56 : Python initialized
2019-01-26 15:16:38.755264 [debug] Server : CommonFramework.cpp:57 : Python version: 2.7.12 (default, Mar 26 2017, 16:23:49) [MSC v.1900 32 bit (Intel)]
2019-01-26 15:16:38.755264 [debug] Server : CommonFramework.cpp:58 : Python prefix: C:\Program Files (x86)\FreeOrionA
2019-01-26 15:16:38.755264 [debug] Server : CommonFramework.cpp:59 : Python module search path: C:\Program Files (x86)\FreeOrionA\python27.zip;;C:\Program Files (x86)\FreeOrionA\Lib\python27;C:\Program Files (x86)\FreeOrionA\Lib\python27\lib-dynload;C:\Program Files (x86)\FreeOrionA\Lib\python27\lib-dynload\RelWithDebInfo;C:\Program Files (x86)\FreeOrionA\Lib\python27\plat-win32;C:\Program Files (x86)\FreeOrionA
2019-01-26 15:16:38.755264 [debug] Server : CommonFramework.cpp:66 : Initializing C++ interfaces for Python
2019-01-26 15:16:38.756258 [debug] Server : ServerFramework.cpp:59 : Initializing server Python modules
2019-01-26 15:16:39.487304 [debug] Server : LoggingWrapper.cpp:23 : Python stdout and stderr redirected
2019-01-26 15:16:44.633545 [debug] Server : ServerFramework.cpp:93 : Server Python modules successfully initialized!
2019-01-26 15:16:44.633545 [debug] Server : CommonFramework.cpp:97 : FreeOrion Python interface successfully initialized!
2019-01-26 15:16:44.633545 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:44.633545 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.633545 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.634542 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.634542 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.634542 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.634542 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.634542 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.634542 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.635540 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.635540 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.635540 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.635540 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.635540 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.635540 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.635540 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.636537 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.636537 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.636537 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.636537 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.636537 [debug] Server : ServerNetworking.cpp:582 : ServerNetworking::AcceptConnection : connected to new player
2019-01-26 15:16:44.964662 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:44.964662 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:44.964662 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:44.964662 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0123E408)::EstablishPlayer(2, AI_4, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:44.964662 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:44.964662 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:44.964662 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:44.964662 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:44.965658 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0371F868)::EstablishPlayer(20, AI_10, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:44.965658 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:44.965658 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:44.965658 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:44.965658 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:44.965658 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 03720368)::EstablishPlayer(18, AI_18, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:44.965658 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:44.969646 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:44.969646 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:44.969646 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:44.969646 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0327C9E8)::EstablishPlayer(7, AI_15, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:44.970644 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:44.970644 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:44.970644 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:44.970644 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:44.971641 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0318D270)::EstablishPlayer(15, AI_17, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:44.971641 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:45.624896 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:45.624896 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:45.624896 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:45.624896 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 031DAA58)::EstablishPlayer(3, AI_16, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:45.624896 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:46.379876 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:46.379876 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:46.379876 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:46.380873 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 03720568)::EstablishPlayer(12, AI_11, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:46.380873 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:46.677082 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:46.677082 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:46.677082 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:46.678079 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 030D1798)::EstablishPlayer(4, AI_5, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:46.678079 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:46.701017 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:46.702014 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:46.702014 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:46.702014 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0371F968)::EstablishPlayer(14, AI_3, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:46.702014 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:46.896495 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:46.896495 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:46.896495 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:46.897492 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0371F768)::EstablishPlayer(16, AI_6, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:46.897492 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.116905 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:47.116905 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.116905 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.116905 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0371F468)::EstablishPlayer(9, AI_7, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.117903 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.188714 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:47.188714 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.188714 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.189711 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 012332D0)::EstablishPlayer(5, AI_19, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.189711 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.366239 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:47.366239 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.366239 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.366239 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 03720168)::EstablishPlayer(19, AI_9, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.366239 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.461983 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:47.462980 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.462980 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.462980 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 03720268)::EstablishPlayer(13, AI_20, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.462980 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.511864 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:47.511864 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.511864 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.511864 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0371F668)::EstablishPlayer(11, AI_12, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.511864 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.517834 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:47.517834 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.518831 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.518831 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0371EF68)::EstablishPlayer(10, AI_8, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.518831 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.520839 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:47.521824 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.521824 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.521824 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 03720668)::EstablishPlayer(8, AI_14, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.521824 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.548751 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:47.548751 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.548751 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.548751 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 03173CE8)::EstablishPlayer(6, AI_1, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.548751 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.591667 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 335
2019-01-26 15:16:47.591667 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.591667 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.591667 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 0371FA68)::EstablishPlayer(17, AI_13, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.591667 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.603642 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: -1 of type Join Game and size 334
2019-01-26 15:16:47.603642 [debug] Server : ServerFSM.cpp:1160 : (ServerFSM) WaitingForSPGameJoiners.JoinGame
2019-01-26 15:16:47.603642 [debug] Server : Message.cpp:805 : ExtractJoinGameMessageData() from Default_Player_Name_in_WaitingForSPGameJoiners::react(const JoinGame& msg) client type -1
2019-01-26 15:16:47.603642 [debug] Server : ServerNetworking.cpp:121 : PlayerConnection(@ 03720B68)::EstablishPlayer(21, AI_2, 0, v0.4.7 [build 2017-04-24.60d06dc] MSVC 2015)
2019-01-26 15:16:47.603642 [debug] Server : ServerFSM.cpp:1215 : (ServerFSM) WaitingForSPGameJoiners.CheckStartConditions
2019-01-26 15:16:47.603642 [debug] Server : ServerFSM.cpp:1220 : WaitingForSPGameJoiners::react(const CheckStartConditions& u) : have all 21 expected players connected.
2019-01-26 15:16:47.603642 [debug] Server : ServerFSM.cpp:1227 : Loading SP game save file: 

PrVonTuckIII
Space Krill
Posts: 6
Joined: Thu Jan 24, 2019 6:06 pm

Re: Game stalling (0.4.7.1)

#4 Post by PrVonTuckIII »

The second half (too many characters to post together):

Code: Select all

C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0690_20190125_122600.sav
2019-01-26 15:16:47.604633 [debug] Server : SaveLoad.cpp:303 : Reading binary iarchive
2019-01-26 15:16:48.915570 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : deserializing universe width: 2589.08
2019-01-26 15:16:49.708130 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : deserializing 0 ship designs
2019-01-26 15:16:50.645100 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : deserializing empire object visibility for 21, 21, 21, 21 empires
2019-01-26 15:16:50.934853 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : deserializing 17723 objects
2019-01-26 15:16:50.952806 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : deserializing 82336 destroyed object ids
2019-01-26 15:16:54.458626 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : deserializing empire known objects for 21 empires
2019-01-26 15:16:54.458626 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : deserializing last allocated ids
2019-01-26 15:16:54.596765 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : deserializing 18 types of statistic
2019-01-26 15:16:54.596765 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : deserializing done
2019-01-26 15:16:54.596765 [debug] Server : SerializeUniverse.cpp:131 : Universe::serialize : updating empires' latest known object destruction states
2019-01-26 15:16:54.672510 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:16:54.672510 [debug] Server : SaveLoad.cpp:315 : Done deserializing
2019-01-26 15:16:54.753873 [debug] Server : SaveLoad.cpp:380 : LoadGame : Successfully loaded save file
2019-01-26 15:16:54.754870 [debug] Server : ScopedTimer.cpp:28 : LoadGame: C:/Users\Sai\AppData\Roaming\FreeOrion\save\auto\FreeOrion_Professor_Sol_0690_20190125_122600.sav time:     7150 ms
2019-01-26 15:16:54.754870 [debug] Server : ServerApp.cpp:1076 : ServerApp::LoadGameInit
2019-01-26 15:16:55.239439 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 1 ========
2019-01-26 15:16:56.416750 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:56.699003 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 128664 microseconds with 1589.7 total Production Points
2019-01-26 15:16:56.794782 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 2 ========
2019-01-26 15:16:56.839668 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:56.882555 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 31916 microseconds with 2269.15 total Production Points
2019-01-26 15:16:56.998266 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 3 ========
2019-01-26 15:16:57.000240 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:57.001237 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 885.825 total Production Points
2019-01-26 15:16:57.080027 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 4 ========
2019-01-26 15:16:57.137982 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:57.198287 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 32919 microseconds with 715.33 total Production Points
2019-01-26 15:16:57.264800 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 5 ========
2019-01-26 15:16:57.297717 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:57.330631 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 32914 microseconds with 957.55 total Production Points
2019-01-26 15:16:57.412403 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 6 ========
2019-01-26 15:16:57.440328 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:57.464275 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 1186.08 total Production Points
2019-01-26 15:16:57.555991 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 7 ========
2019-01-26 15:16:57.622811 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:57.683649 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 32913 microseconds with 1484.3 total Production Points
2019-01-26 15:16:57.773407 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 8 ========
2019-01-26 15:16:57.893242 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:57.992980 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 60842 microseconds with 1445.07 total Production Points
2019-01-26 15:16:58.101645 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 9 ========
2019-01-26 15:16:58.170460 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:58.235286 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 56846 microseconds with 2177.24 total Production Points
2019-01-26 15:16:58.329540 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 10 ========
2019-01-26 15:16:58.330537 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:58.330537 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 448.183 total Production Points
2019-01-26 15:16:58.419807 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 11 ========
2019-01-26 15:16:58.424795 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:58.424795 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 1995.65 total Production Points
2019-01-26 15:16:58.547972 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 12 ========
2019-01-26 15:16:58.611314 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:58.671157 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 58845 microseconds with 2694.26 total Production Points
2019-01-26 15:16:58.793336 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 13 ========
2019-01-26 15:16:58.901048 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:58.997019 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 27925 microseconds with 2390.94 total Production Points
2019-01-26 15:16:59.095761 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 14 ========
2019-01-26 15:16:59.154605 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:59.211452 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 30917 microseconds with 2056.78 total Production Points
2019-01-26 15:16:59.296226 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 15 ========
2019-01-26 15:16:59.368034 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:59.436850 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 27925 microseconds with 1619.01 total Production Points
2019-01-26 15:16:59.526610 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 16 ========
2019-01-26 15:16:59.533592 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:59.538578 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 1016.4 total Production Points
2019-01-26 15:16:59.610386 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 17 ========
2019-01-26 15:16:59.679202 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:59.745026 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 28922 microseconds with 1013.14 total Production Points
2019-01-26 15:16:59.825816 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 18 ========
2019-01-26 15:16:59.841815 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:59.854742 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 1377.91 total Production Points
2019-01-26 15:16:59.961465 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 19 ========
2019-01-26 15:16:59.962462 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:16:59.962462 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 25 total Production Points
2019-01-26 15:17:00.006345 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 20 ========
2019-01-26 15:17:00.007343 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:17:00.008339 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 0 microseconds with 684.806 total Production Points
2019-01-26 15:17:00.072169 [debug] Server : Empire.cpp:3369 : ========= Production Update for empire: 21 ========
2019-01-26 15:17:00.079151 [debug] Server : Empire.cpp:1043 : ProductionQueue::Update: Simulating future turns of production queue
2019-01-26 15:17:00.088126 [debug] Server : Empire.cpp:1258 : ProductionQueue::Update: Projections took 996 microseconds with 891.788 total Production Points
2019-01-26 15:17:00.116527 [debug] Server : ServerApp.cpp:1383 : ServerApp::GetPlayerInfoMap: Compiling PlayerInfo for each player
2019-01-26 15:17:00.116527 [debug] Server : ServerApp.cpp:1203 : ServerApp::CommonGameInit: Sending GameStartMessages to players
2019-01-26 15:17:00.132008 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:00.157940 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:00.168909 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:00.169907 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 637 ship designs
2019-01-26 15:17:00.182872 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:00.288590 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 16458 objects
2019-01-26 15:17:00.288590 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 3246 destroyed object ids
2019-01-26 15:17:00.289587 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:00.289587 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:00.344441 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:00.344441 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:00.344441 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:00.345438 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:00.411263 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:00.416250 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:00.422235 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:00.423231 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 301 ship designs
2019-01-26 15:17:00.428218 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:00.453151 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 5276 objects
2019-01-26 15:17:00.455146 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 3217 destroyed object ids
2019-01-26 15:17:00.455146 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:00.455146 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:00.513988 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:00.513988 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:00.513988 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:00.514986 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:00.575891 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:00.586861 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:00.595835 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:00.596832 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 428 ship designs
2019-01-26 15:17:00.604782 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:00.656658 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 9912 objects
2019-01-26 15:17:00.656658 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 7293 destroyed object ids
2019-01-26 15:17:00.656658 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:00.656658 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:00.712509 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:00.712509 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:00.712509 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:00.713506 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:00.800307 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:00.819225 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:00.830195 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:00.831192 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 428 ship designs
2019-01-26 15:17:00.846150 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:00.922952 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 14129 objects
2019-01-26 15:17:00.923949 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 10947 destroyed object ids
2019-01-26 15:17:00.923949 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:00.923949 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:00.995762 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:00.996760 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:00.996760 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:00.997757 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:01.133736 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:01.153682 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:01.167645 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:01.168642 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 430 ship designs
2019-01-26 15:17:01.185597 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:01.269912 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 10588 objects
2019-01-26 15:17:01.269912 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 8212 destroyed object ids
2019-01-26 15:17:01.269912 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:01.269912 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:01.360197 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:01.360197 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:01.360197 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:01.362193 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:01.494358 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:01.520289 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:01.539240 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:01.541234 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 442 ship designs
2019-01-26 15:17:01.566168 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:01.679863 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 14190 objects
2019-01-26 15:17:01.681859 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 10649 destroyed object ids
2019-01-26 15:17:01.681859 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:01.681859 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:01.782592 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:01.782592 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:01.782592 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:01.785583 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:01.920220 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:01.944156 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:01.961110 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:01.963106 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 456 ship designs
2019-01-26 15:17:01.990033 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:02.111709 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 11213 objects
2019-01-26 15:17:02.112705 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 7653 destroyed object ids
2019-01-26 15:17:02.112705 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:02.112705 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:02.233385 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:02.233385 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:02.233385 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:02.234381 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:02.367539 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:02.394465 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:02.412417 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:02.415409 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 389 ship designs
2019-01-26 15:17:02.441339 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:02.576488 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 11556 objects
2019-01-26 15:17:02.576488 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 7989 destroyed object ids
2019-01-26 15:17:02.576488 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:02.577486 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:02.699163 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:02.699163 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:02.699163 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:02.701155 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:02.847772 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:02.877683 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:02.897631 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:02.898627 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 425 ship designs
2019-01-26 15:17:02.924557 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:03.068173 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 13261 objects
2019-01-26 15:17:03.069171 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 10418 destroyed object ids
2019-01-26 15:17:03.069171 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:03.069171 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:03.181869 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:03.181869 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:03.181869 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:03.183864 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:03.334461 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:03.360392 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:03.377347 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:03.379341 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 381 ship designs
2019-01-26 15:17:03.413251 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:03.552878 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 13988 objects
2019-01-26 15:17:03.552878 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 11524 destroyed object ids
2019-01-26 15:17:03.552878 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:03.552878 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:03.675550 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:03.675550 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:03.675550 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:03.677545 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:03.803208 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:03.829139 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:03.845098 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:03.847091 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 518 ship designs
2019-01-26 15:17:03.868035 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:04.003672 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 11115 objects
2019-01-26 15:17:04.003672 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 6499 destroyed object ids
2019-01-26 15:17:04.003672 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:04.003672 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:04.111385 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:04.111385 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:04.111385 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:04.112382 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:04.258990 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:04.292899 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:04.311849 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:04.313848 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 466 ship designs
2019-01-26 15:17:04.345758 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:04.501342 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 15492 objects
2019-01-26 15:17:04.501342 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 11269 destroyed object ids
2019-01-26 15:17:04.501342 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:04.501342 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:04.617032 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:04.617032 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:04.617032 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:04.619027 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:04.742697 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:04.771620 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:04.788574 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:04.790569 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 463 ship designs
2019-01-26 15:17:04.818494 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:04.959118 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 13554 objects
2019-01-26 15:17:04.960116 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 9213 destroyed object ids
2019-01-26 15:17:04.960116 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:04.960116 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:05.069822 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:05.069822 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:05.069822 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:05.071817 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:05.218424 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:05.255326 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:05.280260 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:05.283252 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 430 ship designs
2019-01-26 15:17:05.322147 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:05.548542 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 18718 objects
2019-01-26 15:17:05.549539 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 15018 destroyed object ids
2019-01-26 15:17:05.549539 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:05.549539 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:05.696148 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:05.696148 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:05.696148 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:05.699140 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:05.877663 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:05.923540 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:05.948474 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:05.950467 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 464 ship designs
2019-01-26 15:17:05.991359 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:06.225732 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 16660 objects
2019-01-26 15:17:06.226730 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 12795 destroyed object ids
2019-01-26 15:17:06.226730 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:06.226730 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:06.382313 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:06.382313 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:06.382313 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:06.385306 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:06.586279 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:06.635149 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:06.661080 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:06.666067 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 462 ship designs
2019-01-26 15:17:06.721917 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:06.998179 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 17375 objects
2019-01-26 15:17:06.999176 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 12826 destroyed object ids
2019-01-26 15:17:06.999176 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:06.999176 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:07.164734 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:07.165731 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:07.165731 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:07.168723 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:07.427033 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:07.476899 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:07.501836 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:07.503828 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 541 ship designs
2019-01-26 15:17:07.545715 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:07.810008 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 17902 objects
2019-01-26 15:17:07.811006 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 13209 destroyed object ids
2019-01-26 15:17:07.811006 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:07.811006 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:07.961603 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:07.962600 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:07.962600 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:07.965593 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:08.229403 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:08.280261 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:08.308187 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:08.311179 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 509 ship designs
2019-01-26 15:17:08.357055 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:08.604395 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 17312 objects
2019-01-26 15:17:08.605393 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 11976 destroyed object ids
2019-01-26 15:17:08.605393 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:08.605393 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:08.751002 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:08.751002 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:08.751002 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:08.753995 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:08.998848 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:09.057691 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:09.087612 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:09.093596 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 533 ship designs
2019-01-26 15:17:09.140470 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:09.456627 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 20947 objects
2019-01-26 15:17:09.457625 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 14856 destroyed object ids
2019-01-26 15:17:09.457625 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:09.457625 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:09.613207 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:09.613207 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:09.613207 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:09.617195 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:10.107877 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:10.169711 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:10.202623 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:10.206612 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 573 ship designs
2019-01-26 15:17:10.272437 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:10.713799 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 21884 objects
2019-01-26 15:17:10.714797 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 15841 destroyed object ids
2019-01-26 15:17:10.714797 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:10.714797 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:10.867389 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:10.867389 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:10.867389 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:10.873372 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:13.624051 [debug] Server : SerializeUniverse.cpp:54 : Universe::serialize : Getting gamestate data
2019-01-26 15:17:13.714808 [debug] Server : Universe.cpp:2897 : GetEmpireKnownObjectsToSerialize
2019-01-26 15:17:13.759688 [debug] Server : SerializeUniverse.cpp:70 : Universe::serialize : serializing universe width: 2589.08
2019-01-26 15:17:13.763678 [debug] Server : SerializeUniverse.cpp:75 : Universe::serialize : serializing 686 ship designs
2019-01-26 15:17:13.832493 [debug] Server : SerializeUniverse.cpp:83 : Universe::serialize : serializing empire object visibility for 1, 1, 1, 1 empires
2019-01-26 15:17:14.242397 [debug] Server : SerializeUniverse.cpp:96 : Universe::serialize : serializing 35030 objects
2019-01-26 15:17:14.244392 [debug] Server : SerializeUniverse.cpp:102 : Universe::serialize : serializing 26741 destroyed object ids
2019-01-26 15:17:14.244392 [debug] Server : SerializeUniverse.cpp:109 : Universe::serialize : serializing empire known objects for 0 empires
2019-01-26 15:17:14.244392 [debug] Server : SerializeUniverse.cpp:114 : Universe::serialize : serializing last allocated ids
2019-01-26 15:17:14.377038 [debug] Server : SerializeUniverse.cpp:118 : Universe::serialize : serializing 18 types of statistic
2019-01-26 15:17:14.377038 [debug] Server : SerializeUniverse.cpp:120 : Universe::serialize : serializing done
2019-01-26 15:17:14.377038 [debug] Server : SerializeUniverse.cpp:123 : Universe::serialize : Cleaning up temporary data
2019-01-26 15:17:14.382024 [debug] Server : SerializeUniverse.cpp:140 : Universe::serialize done
2019-01-26 15:17:14.729116 [debug] Server : ServerFSM.cpp:1157 : (ServerFSM) ~WaitingForSPGameJoiners
2019-01-26 15:17:14.740595 [debug] Server : ServerFSM.cpp:1386 : (ServerFSM) PlayingGame
2019-01-26 15:17:14.740595 [debug] Server : ServerFSM.cpp:1482 : (ServerFSM) WaitingForTurnEnd
2019-01-26 15:17:14.741592 [debug] Server : ServerFSM.cpp:1629 : (ServerFSM) WaitingForTurnEndIdle
2019-01-26 15:17:14.741592 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: 1 of type Request combat logs and size 98066
2019-01-26 15:17:14.741592 [debug] Server : ServerFSM.cpp:1461 : (ServerFSM) PlayingGame::RequestCombatLogs message received
2019-01-26 15:17:15.039342 [debug] Server : ServerApp.cpp:896 : UpdateCombatLogs returning 5208 logs to player 1
2019-01-26 15:18:19.766901 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: 2 of type Turn Orders and size 18391
2019-01-26 15:18:19.766901 [debug] Server : ServerFSM.cpp:1489 : (ServerFSM) WaitingForTurnEnd.TurnOrders
2019-01-26 15:18:19.770891 [debug] Server : ServerFSM.cpp:1552 : WaitingForTurnEnd.TurnOrders : Received orders from player 2
2019-01-26 15:18:19.775878 [debug] Server : ServerFSM.cpp:1603 : (ServerFSM) WaitingForTurnEnd.CheckTurnEndConditions
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1488 : ServerApp::AllOrdersReceived for turn: 690
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 1
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 2
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 3
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 4
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 5
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 6
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 7
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 8
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 9
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 10
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 11
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 12
2019-01-26 15:18:19.775878 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 13
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 14
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 15
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 16
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 17
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 18
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 19
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 20
2019-01-26 15:18:19.776875 [debug] Server : ServerApp.cpp:1493 :  ... have orders from empire id: 21
2019-01-26 15:18:36.897250 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: 5 of type Turn Orders and size 1115
2019-01-26 15:18:36.897250 [debug] Server : ServerFSM.cpp:1489 : (ServerFSM) WaitingForTurnEnd.TurnOrders
2019-01-26 15:18:36.897250 [debug] Server : ServerFSM.cpp:1552 : WaitingForTurnEnd.TurnOrders : Received orders from player 5
2019-01-26 15:18:36.902236 [debug] Server : ServerFSM.cpp:1603 : (ServerFSM) WaitingForTurnEnd.CheckTurnEndConditions
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1488 : ServerApp::AllOrdersReceived for turn: 690
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 1
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 2
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 3
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 4
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 5
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 6
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 7
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 8
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 9
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 10
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 11
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 12
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 13
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 14
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 15
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 16
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 17
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 18
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1493 :  ... have orders from empire id: 19
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 20
2019-01-26 15:18:36.902236 [debug] Server : ServerApp.cpp:1493 :  ... have orders from empire id: 21
2019-01-26 15:18:38.269581 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: 1 of type Turn Orders and size 372
2019-01-26 15:18:38.269581 [debug] Server : ServerFSM.cpp:1489 : (ServerFSM) WaitingForTurnEnd.TurnOrders
2019-01-26 15:18:38.270580 [debug] Server : ServerFSM.cpp:1552 : WaitingForTurnEnd.TurnOrders : Received orders from player 1
2019-01-26 15:18:38.274567 [debug] Server : ServerFSM.cpp:1579 : WaitingForTurnEnd.TurnOrders : Orders received from local human player, raising AI process priority
2019-01-26 15:18:38.275567 [debug] Server : ServerFSM.cpp:1603 : (ServerFSM) WaitingForTurnEnd.CheckTurnEndConditions
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1488 : ServerApp::AllOrdersReceived for turn: 690
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1493 :  ... have orders from empire id: 1
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 2
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 3
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 4
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 5
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 6
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 7
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 8
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 9
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 10
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 11
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 12
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 13
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 14
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 15
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 16
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 17
2019-01-26 15:18:38.275567 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 18
2019-01-26 15:18:38.276564 [debug] Server : ServerApp.cpp:1493 :  ... have orders from empire id: 19
2019-01-26 15:18:38.276564 [debug] Server : ServerApp.cpp:1491 :  ... no orders from empire id: 20
2019-01-26 15:18:38.276564 [debug] Server : ServerApp.cpp:1493 :  ... have orders from empire id: 21
2019-01-26 15:18:47.463269 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 1
2019-01-26 15:18:47.463269 [debug] Server : ServerFSM.cpp:227 : ServerFSM::HandleNonLobbyDisconnection : Lost connection to player #1, named "Professor Von Tuck III"; server terminating.
2019-01-26 15:18:47.467258 [debug] Server : ServerFSM.cpp:241 : ServerFSM::HandleNonLobbyDisconnection : All human players disconnected; server terminating.
2019-01-26 15:18:47.467258 [debug] Server : ServerFSM.cpp:1455 : (ServerFSM) PlayingGame.ShutdownServer
2019-01-26 15:18:47.467258 [debug] Server : ServerFSM.cpp:1633 : (ServerFSM) ~WaitingForTurnEndIdle
2019-01-26 15:18:47.467258 [debug] Server : ServerFSM.cpp:1486 : (ServerFSM) ~WaitingForTurnEnd
2019-01-26 15:18:47.467258 [debug] Server : ServerFSM.cpp:1389 : (ServerFSM) ~PlayingGame
2019-01-26 15:18:47.467258 [debug] Server : ServerFSM.cpp:1830 : (ServerFSM) ShuttingDownServer
2019-01-26 15:18:47.468257 [debug] Server : ServerFSM.cpp:1837 : ShuttingDownServer informing AIs game is ending
2019-01-26 15:18:47.471247 [debug] Server : ServerFSM.cpp:1851 : ShuttingDownServer expecting 20 AIs to ACK shutdown.
2019-01-26 15:18:47.471247 [debug] Server : ServerFSM.cpp:1900 : (ServerFSM) ShuttingDownServer.CheckEndConditions
2019-01-26 15:18:47.496180 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: 5 of type Acknowledge Shut Down Server and size 8
2019-01-26 15:18:47.496180 [debug] Server : ServerFSM.cpp:1865 : (ServerFSM) ShuttingDownServer.LeaveGame
2019-01-26 15:18:47.496180 [debug] Server : ServerFSM.cpp:1872 : Shutdown ACK received for AI 5
2019-01-26 15:18:47.496180 [debug] Server : ServerFSM.cpp:1900 : (ServerFSM) ShuttingDownServer.CheckEndConditions
2019-01-26 15:18:47.497178 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 5
2019-01-26 15:18:47.527097 [debug] Server : ServerNetworking.cpp:233 : Server received message from player id: 2 of type Acknowledge Shut Down Server and size 8
2019-01-26 15:18:47.527097 [debug] Server : ServerFSM.cpp:1865 : (ServerFSM) ShuttingDownServer.LeaveGame
2019-01-26 15:18:47.527097 [debug] Server : ServerFSM.cpp:1872 : Shutdown ACK received for AI 2
2019-01-26 15:18:47.527097 [debug] Server : ServerFSM.cpp:1900 : (ServerFSM) ShuttingDownServer.CheckEndConditions
2019-01-26 15:18:47.527097 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 2
2019-01-26 15:18:52.468886 [debug] Server : ServerApp.cpp:466 : Shutdown timed out.  Disconnecting remaining clients.
2019-01-26 15:18:52.468886 [debug] Server : ServerFSM.cpp:1919 : (ServerFSM) ShuttingDownServer.DisconnectClients
2019-01-26 15:18:52.468886 [error] Server : Process.cpp:148 : Process::Impl::Kill : Error terminating process: Access is denied.
2019-01-26 15:18:52.469883 [error] Server : Process.cpp:148 : Process::Impl::Kill : Error terminating process: Access is denied.
2019-01-26 15:18:52.471879 [debug] Server : ServerNetworking.cpp:495 : ServerNetworking::DisconnectAll
2019-01-26 15:18:52.471879 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 4
2019-01-26 15:18:52.471879 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 6
2019-01-26 15:18:52.471879 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 15
2019-01-26 15:18:52.471879 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 3
2019-01-26 15:18:52.471879 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 7
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 10
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 9
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 11
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 16
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 20
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 14
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 17
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 19
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 13
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 18
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 12
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 8
2019-01-26 15:18:52.472877 [debug] Server : ServerNetworking.cpp:593 : ServerNetworking::DisconnectImpl : disconnecting player 21
2019-01-26 15:18:52.473876 [debug] Server : ServerFSM.cpp:1862 : (ServerFSM) ~ShuttingDownServer
2019-01-26 15:18:52.473876 [debug] Server : ServerApp.cpp:156 : ServerApp::~ServerApp
2019-01-26 15:18:52.482849 [debug] Server : CommonFramework.cpp:126 : Cleaned up FreeOrion Python interface
2019-01-26 15:18:52.482849 [debug] Server : ServerApp.cpp:160 : Server exited cleanly.
2019-01-26 15:18:53.887095 [debug] Server : dmain.cpp:118 : freeorion server main exited cleanly.

User avatar
The Silent One
Graphics
Posts: 1129
Joined: Tue Jul 01, 2003 8:27 pm

Re: Game stalling (0.4.7.1)

#5 Post by The Silent One »

PrVonTuckIII wrote: Sat Jan 26, 2019 8:33 pmHowever, the game seems to be experiencing... well I guess a stall is the best word for it. I can load a game, and I can select ships, give move orders, etc, but I can't progress turns (clicking the button does nothing, nor does trying to exit by closing the main game window).
You seem to be running a large game with many empires (>20?) and also >700 turns. Your CPU may not be able handle that many game objects. When object interactions are calculated (e. g. when you select a ship), that takes a lot of time which should be the stall.
If I provided any images, code, scripts or other content here, it's released under GPL 2.0 and CC-BY-SA 3.0.

PrVonTuckIII
Space Krill
Posts: 6
Joined: Thu Jan 24, 2019 6:06 pm

Re: Game stalling (0.4.7.1)

#6 Post by PrVonTuckIII »

The Silent One wrote: Sun Jan 27, 2019 9:25 am You seem to be running a large game with many empires (>20?) and also >700 turns. Your CPU may not be able handle that many game objects. When object interactions are calculated (e. g. when you select a ship), that takes a lot of time which should be the stall.
Right, but it was working just fine a day ago, only a dozen turns before. Hence why I'm confused as to the problem. I haven't touched the game's code or settings, nor have I made any changes to my firewalls, either.

Edit: I tried starting a new game. It seemed to work fine, at least for the first few turns, so perhaps you're correct.

Post Reply