20:33:43.355773 [info] log : logger.cpp:198 : Added logger named "log" 20:33:43.356765 [info] log : logger.cpp:198 : Added logger named "IDallocator" 20:33:43.356765 [info] log : logger.cpp:367 : Logger initialized at Mon Dec 17 20:33:43 2018 20:33:43.356765 [info] log : logger.cpp:330 : Setting "log" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "log" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "client" logger threshold to "debug". 20:33:43.356765 [info] log : logger.cpp:330 : Setting "IDallocator" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "IDallocator" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "log" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "log" from optionsDB using threshold debug 20:33:43.356765 [info] log : loggerwithoptionsdb.cpp:91 : Initialized OptionsDB logging configuration. 20:33:43.356765 [info] log : logger.cpp:330 : Setting "ai" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "ai" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "client" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "client" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "server" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "server" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "combat_log" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "combat_log" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "combat" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "combat" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "effects" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "effects" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "FSM" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "FSM" from optionsDB using threshold debug 20:33:43.356765 [info] log : logger.cpp:330 : Setting "network" logger threshold to "debug". 20:33:43.356765 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "network" from optionsDB using threshold debug 20:33:43.357261 [info] log : logger.cpp:330 : Setting "python" logger threshold to "debug". 20:33:43.357261 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "python" from optionsDB using threshold debug 20:33:43.357261 [info] log : logger.cpp:330 : Setting "timer" logger threshold to "debug". 20:33:43.357261 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "timer" from optionsDB using threshold debug 20:33:43.357261 [info] client : humanclientapp.cpp:253 : v0.4.8+ blockade-UI [build 2018-12-16.061d2be] MSVC 2017 20:33:43.357261 [info] client : humanclientapp.cpp:256 : GL Version String: 4.6.0 NVIDIA 390.65 20:33:43.357261 [info] client : dependencyversions.cpp:81 : Dependency versions from headers: 20:33:43.357261 [info] client : dependencyversions.cpp:84 : Boost: 1_66 20:33:43.357261 [info] client : dependencyversions.cpp:84 : FreeType: 2.9.0 20:33:43.357261 [info] client : dependencyversions.cpp:84 : PNG: 1.6.34 20:33:43.357261 [info] client : dependencyversions.cpp:84 : SDL: 2.0.8 20:33:43.357261 [info] client : dependencyversions.cpp:84 : libvorbis: Xiph.Org libVorbis 1.3.5 20:33:43.357261 [info] client : dependencyversions.cpp:84 : zlib: 1.2.11 20:33:43.374931 [debug] client : sound.cpp:355 : OpenAL initialized. Version 1.1 ALSOFT 1.18.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_EXT_SOURCE_RADIUS AL_EXT_STEREO_ANGLES AL_LOKI_quadriphonic AL_SOFT_block_alignment AL_SOFT_deferred_updates AL_SOFT_direct_channels AL_SOFT_gain_clamp_ex AL_SOFT_loop_points AL_SOFT_MSADPCM AL_SOFT_source_latency AL_SOFT_source_length AL_SOFT_source_resampler AL_SOFT_source_spatialize 20:33:43.374931 [debug] client : sound.cpp:252 : Audio enabled. 20:33:43.384880 [debug] client : hotkeys.cpp:217 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_DOWN' for hotkey ui.pan.down 20:33:43.384880 [debug] client : hotkeys.cpp:217 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_LEFT' for hotkey ui.pan.left 20:33:43.384880 [debug] client : hotkeys.cpp:217 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_RIGHT' for hotkey ui.pan.right 20:33:43.384880 [debug] client : hotkeys.cpp:217 : Hotkey::ReadFromOptions : Typing-unsafe key spec: 'MOD_KEY_LCTRL | MOD_KEY_RCTRL+GGK_UP' for hotkey ui.pan.up 20:33:43.384880 [debug] client : i18n.cpp:35 : Detected language: Previously specified C:\Users\X\Documents\FreeOrion SDK\FreeOrion\default\stringtables\en.txt 20:33:43.463740 [debug] client : clientui.cpp:444 : loading 15 charsets for current stringtable characters 20:33:43.463740 [debug] client : clientui.cpp:448 : Non-default stringtable! 20:33:43.476640 [debug] client : clientui.cpp:459 : loading 15 charsets for default stringtable characters 20:33:43.476640 [debug] client : clientui.cpp:462 : combined stringtable charsets have 15 charsets 20:33:43.476640 [debug] client : clientui.cpp:473 : Loading 15 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, Arabic Presentation Forms-B, 20:33:43.606128 [debug] client : humanclientapp.cpp:1488 : Limited FPS to 60 20:33:43.606624 [debug] client : humanclientapp.cpp:172 : OpenGL Version Number: 4.7 20:33:43.645312 [info] log : logger.cpp:198 : Added logger named "timer" 20:33:43.645312 [info] log : logger.cpp:330 : Setting "timer" logger threshold to "debug". 20:33:43.645312 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "timer" from optionsDB using threshold debug 20:33:43.645312 [debug] timer : scopedtimer.cpp:34 : parse_file "keymaps.inf" time: 38 ms 20:33:43.645808 [info] log : logger.cpp:198 : Added logger named "FSM" 20:33:43.645808 [info] log : logger.cpp:330 : Setting "FSM" logger threshold to "debug". 20:33:43.645808 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "FSM" from optionsDB using threshold debug 20:33:43.645808 [debug] client : gamerules.cpp:22 : Adding options rules 20:33:43.645808 [debug] client : gamerules.h:105 : Added game rule named RULE_RESEED_PRNG_SERVER with default value true 20:33:43.645808 [debug] client : gamerules.h:105 : Added game rule named RULE_STARLANES_EVERYWHERE with default value false 20:33:43.645808 [debug] client : gamerules.h:105 : Added game rule named RULE_STOCKPILE_IMPORT_LIMITED with default value false 20:33:43.645808 [debug] client : gamerules.h:105 : Added game rule named RULE_PRODUCTION_QUEUE_FRONTLOAD_FACTOR with default value 0 20:33:43.645808 [debug] client : gamerules.h:105 : Added game rule named RULE_PRODUCTION_QUEUE_TOPPING_UP_FACTOR with default value 0 20:33:43.645808 [debug] client : gamerules.h:105 : Added game rule named RULE_CHEAP_AND_FAST_SHIP_PRODUCTION with default value false 20:33:43.646304 [debug] client : gamerules.h:105 : Added game rule named RULE_SHIP_SPEED_FACTOR with default value 1 20:33:43.646304 [debug] client : gamerules.h:105 : Added game rule named RULE_SHIP_STRUCTURE_FACTOR with default value 1 20:33:43.646304 [debug] client : gamerules.h:105 : Added game rule named RULE_CHEAP_AND_FAST_BUILDING_PRODUCTION with default value false 20:33:43.646304 [debug] client : gamerules.h:105 : Added game rule named RULE_CHEAP_AND_FAST_TECH_RESEARCH with default value false 20:33:43.646304 [debug] client : gamerules.h:105 : Added game rule named RULE_NUM_COMBAT_ROUNDS with default value 3 20:33:43.646800 [debug] client : humanclientapp.cpp:1093 : HumanClientApp::HandleFocusChange(Gained Focus) 20:33:43.687968 [debug] client : sitreppanel.cpp:771 : SitRepPanel::Update() 20:33:43.723680 [debug] timer : scopedtimer.cpp:34 : parse_file "SD_COLONY_BASE.focs.txt" time: 75 ms 20:33:43.724176 [debug] timer : scopedtimer.cpp:34 : parse_file "FLD_ACCRETION_DISC.focs.txt" time: 77 ms 20:33:43.726656 [debug] timer : scopedtimer.cpp:34 : parse_file "ENC_SHIP_HULL.focs.txt" time: 78 ms 20:33:43.727648 [debug] client : gamerulesparser.cpp:48 : Adding Double game rule with name: RULE_SHIP_HULL_COST_FACTOR, desc: RULE_SHIP_HULL_COST_FACTOR_DESC, default: 1, min: 0.1, max: 10 20:33:43.727648 [debug] client : gamerules.h:105 : Added game rule named RULE_SHIP_HULL_COST_FACTOR with default value 1 20:33:43.728144 [debug] client : gamerulesparser.cpp:48 : Adding Double game rule with name: RULE_SHIP_PART_COST_FACTOR, desc: RULE_SHIP_PART_COST_FACTOR_DESC, default: 1, min: 0.1, max: 10 20:33:43.728144 [debug] client : gamerules.h:105 : Added game rule named RULE_SHIP_PART_COST_FACTOR with default value 1 20:33:43.728144 [debug] client : gamerulesparser.cpp:48 : Adding Double game rule with name: RULE_TECH_COST_FACTOR, desc: RULE_TECH_COST_FACTOR_DESC, default: 2, min: 0.1, max: 10 20:33:43.728144 [debug] client : gamerules.h:105 : Added game rule named RULE_TECH_COST_FACTOR with default value 2 20:33:43.728144 [debug] client : gamerulesparser.cpp:48 : Adding Double game rule with name: RULE_BUILDING_COST_FACTOR, desc: RULE_BUILDING_COST_FACTOR_DESC, default: 1, min: 0.1, max: 10 20:33:43.728144 [debug] client : gamerules.h:105 : Added game rule named RULE_BUILDING_COST_FACTOR with default value 1 20:33:43.728144 [debug] client : gamerulesparser.cpp:28 : Adding Boolean game rule with name: RULE_ENABLE_EXPERIMENTORS, desc: RULE_ENABLE_EXPERIMENTORS_DESC, default: true 20:33:43.728640 [debug] client : gamerules.h:105 : Added game rule named RULE_ENABLE_EXPERIMENTORS with default value true 20:33:43.728640 [debug] client : gamerulesparser.cpp:28 : Adding Boolean game rule with name: RULE_ENABLE_SUPER_TESTER, desc: RULE_ENABLE_SUPER_TESTER_DESC, default: true 20:33:43.728640 [debug] client : gamerules.h:105 : Added game rule named RULE_ENABLE_SUPER_TESTER with default value true 20:33:43.728640 [debug] client : gamerulesparser.cpp:63 : Adding String game rule with name: RULE_TEST_STRING, desc: RULE_TEST_STRING_DESC, default: "PLAYER", allowed: "AI_PLAYER", "MODERATOR", "OBSERVER", "PLAYER", 20:33:43.728640 [debug] client : gamerules.h:105 : Added game rule named RULE_TEST_STRING with default value PLAYER 20:33:43.728640 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_TINY, desc: RULE_HABITABLE_SIZE_DESC, default: 1, min: 0, max: 999 20:33:43.728640 [debug] client : gamerules.h:105 : Added game rule named RULE_HABITABLE_SIZE_TINY with default value 1 20:33:43.728640 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_SMALL, desc: RULE_HABITABLE_SIZE_DESC, default: 2, min: 0, max: 999 20:33:43.729136 [debug] client : gamerules.h:105 : Added game rule named RULE_HABITABLE_SIZE_SMALL with default value 2 20:33:43.729136 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_MEDIUM, desc: RULE_HABITABLE_SIZE_DESC, default: 3, min: 0, max: 999 20:33:43.729136 [debug] client : gamerules.h:105 : Added game rule named RULE_HABITABLE_SIZE_MEDIUM with default value 3 20:33:43.729136 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_LARGE, desc: RULE_HABITABLE_SIZE_DESC, default: 4, min: 0, max: 999 20:33:43.729136 [debug] client : gamerules.h:105 : Added game rule named RULE_HABITABLE_SIZE_LARGE with default value 4 20:33:43.729136 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_HUGE, desc: RULE_HABITABLE_SIZE_DESC, default: 5, min: 0, max: 999 20:33:43.729136 [debug] client : gamerules.h:105 : Added game rule named RULE_HABITABLE_SIZE_HUGE with default value 5 20:33:43.729136 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_ASTEROIDS, desc: RULE_HABITABLE_SIZE_DESC, default: 3, min: 0, max: 999 20:33:43.729136 [debug] client : gamerules.h:105 : Added game rule named RULE_HABITABLE_SIZE_ASTEROIDS with default value 3 20:33:43.729136 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_GASGIANT, desc: RULE_HABITABLE_SIZE_DESC, default: 6, min: 0, max: 999 20:33:43.729136 [debug] client : gamerules.h:105 : Added game rule named RULE_HABITABLE_SIZE_GASGIANT with default value 6 20:33:43.729632 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_THRESHOLD_HUMAN_PLAYER_WIN, desc: RULE_THRESHOLD_HUMAN_PLAYER_WIN_DESC, default: 0, min: 0, max: 999 20:33:43.729632 [debug] client : gamerules.h:105 : Added game rule named RULE_THRESHOLD_HUMAN_PLAYER_WIN with default value 0 20:33:43.729632 [debug] client : gamerulesparser.cpp:28 : Adding Boolean game rule with name: RULE_ONLY_ALLIANCE_WIN, desc: RULE_ONLY_ALLIANCE_WIN_DESC, default: true 20:33:43.729632 [debug] client : gamerules.h:105 : Added game rule named RULE_ONLY_ALLIANCE_WIN with default value true 20:33:43.729632 [debug] client : gamerulesparser.cpp:28 : Adding Boolean game rule with name: RULE_ALLOW_CONCEDE, desc: RULE_ALLOW_CONCEDE_DESC, default: false 20:33:43.729632 [debug] client : gamerules.h:105 : Added game rule named RULE_ALLOW_CONCEDE with default value false 20:33:43.729632 [debug] client : gamerulesparser.cpp:37 : Adding Integer game rule with name: RULE_CONCEDE_COLONIES_THRESHOLD, desc: RULE_CONCEDE_COLONIES_THRESHOLD_DESC, default: 1, min: 0, max: 9999 20:33:43.729632 [debug] client : gamerules.h:105 : Added game rule named RULE_CONCEDE_COLONIES_THRESHOLD with default value 1 20:33:43.729632 [debug] client : gamerulesparser.cpp:28 : Adding Boolean game rule with name: RULE_SHIP_PART_BASED_UPKEEP, desc: RULE_SHIP_PART_BASED_UPKEEP_DESC, default: false 20:33:43.729632 [debug] client : gamerules.h:105 : Added game rule named RULE_SHIP_PART_BASED_UPKEEP with default value false 20:33:43.729632 [debug] timer : scopedtimer.cpp:34 : parse_file "game_rules.focs.txt" time: 81 ms 20:33:43.730624 [debug] timer : scopedtimer.cpp:34 : parse_file "SM_ACIREMA_GUARD.focs.txt" time: 82 ms 20:33:43.731616 [debug] timer : scopedtimer.cpp:34 : parse_file "FLD_ION_STORM.focs.txt" time: 7070 µs 20:33:43.731616 [debug] timer : scopedtimer.cpp:34 : parse_file "Categories.inf" time: 80 ms 20:33:43.731616 [debug] timer : scopedtimer.cpp:34 : parse_file "CONC_CAMP_MASTER.focs.txt" time: 84 ms 20:33:43.732608 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_BLACK_HOLE.focs.txt" time: 84 ms 20:33:43.732608 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_CRYSTAL_PLATE.focs.txt" time: 84 ms 20:33:43.735584 [debug] timer : scopedtimer.cpp:34 : parse_file "FLD_MOLECULAR_CLOUD.focs.txt" time: 4317 µs 20:33:43.737072 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_DIAMOND_PLATE.focs.txt" time: 4026 µs 20:33:43.737072 [debug] timer : scopedtimer.cpp:34 : parse_file "CONC_CAMP_SLAVE.focs.txt" time: 5119 µs 20:33:43.737568 [debug] timer : scopedtimer.cpp:34 : parse_file "ARCH_MONOFIL.focs.txt" time: 2924 µs 20:33:43.738065 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_ASTEROID.focs.txt" time: 89 ms 20:33:43.739056 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_FACTORY_PLANET.focs.txt" time: 6424 µs 20:33:43.739552 [debug] timer : scopedtimer.cpp:34 : parse_file "NOVA_BOMB_ACTIVATOR.focs.txt" time: 2678 µs 20:33:43.740544 [debug] timer : scopedtimer.cpp:34 : parse_file "ARCH_PSYCH.focs.txt" time: 2842 µs 20:33:43.742528 [debug] timer : scopedtimer.cpp:34 : parse_file "ABANDONED_COLONY.focs.txt" time: 2928 µs 20:33:43.742528 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_HEAVEN.focs.txt" time: 2180 µs 20:33:43.743025 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_NEUTRONIUM_PLATE.focs.txt" time: 5977 µs 20:33:43.743521 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_MOON.focs.txt" time: 4554 µs 20:33:43.745008 [debug] timer : scopedtimer.cpp:34 : parse_file "FLD_NEBULA_1.focs.txt" time: 8964 µs 20:33:43.745504 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_PLANET.focs.txt" time: 2575 µs 20:33:43.746993 [debug] timer : scopedtimer.cpp:34 : parse_file "ASYMP_MATS.focs.txt" time: 1867 µs 20:33:43.748481 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_PRECURSOR_PLATE.focs.txt" time: 5528 µs 20:33:43.748481 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_PARADISE_PLANET.focs.txt" time: 5224 µs 20:33:43.748976 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_CAMOUFLAGE_ASTEROID.focs.txt" time: 10 ms 20:33:43.748976 [debug] timer : scopedtimer.cpp:34 : parse_file "CONC_CAMP.focs.txt" time: 1826 µs 20:33:43.749968 [debug] timer : scopedtimer.cpp:34 : parse_file "ANCIENT_RUINS.focs.txt" time: 7262 µs 20:33:43.750960 [debug] timer : scopedtimer.cpp:34 : parse_file "CONTROL_GRAV_ARCH.focs.txt" time: 1987 µs 20:33:43.752448 [debug] timer : scopedtimer.cpp:34 : parse_file "ANCIENT_RUINS_DEPLETED.focs.txt" time: 2286 µs 20:33:43.752448 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_PLANET.focs.txt" time: 3568 µs 20:33:43.752944 [debug] timer : scopedtimer.cpp:34 : parse_file "FLD_NEBULA_2.focs.txt" time: 8062 µs 20:33:43.754432 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_ROCK_PLATE.focs.txt" time: 5799 µs 20:33:43.754928 [debug] timer : scopedtimer.cpp:34 : parse_file "FLD_SUBSPACE_RIFT.focs.txt" time: 2271 µs 20:33:43.755424 [debug] timer : scopedtimer.cpp:34 : parse_file "FORCE_ENERGY_STRC.focs.txt" time: 4416 µs 20:33:43.755920 [debug] timer : scopedtimer.cpp:34 : parse_file "COMPUTRONIUM.focs.txt" time: 3590 µs 20:33:43.756913 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_ABADDONI.focs.txt" time: 108 ms 20:33:43.756913 [debug] timer : scopedtimer.cpp:34 : parse_file "AUTO_HISTORY_ANALYSER.focs.txt" time: 4497 µs 20:33:43.757904 [debug] timer : scopedtimer.cpp:34 : parse_file "ECCENTRIC_ORBIT.focs.txt" time: 2080 µs 20:33:43.758400 [debug] timer : scopedtimer.cpp:34 : parse_file "GALACTIC_INFRA.focs.txt" time: 2729 µs 20:33:43.758400 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_CRYSTALLIZED_ASTEROID.focs.txt" time: 9525 µs 20:33:43.758896 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_STD_PLATE.focs.txt" time: 4788 µs 20:33:43.759392 [debug] timer : scopedtimer.cpp:34 : parse_file "EXTINCT_BANFORO.focs.txt" time: 1334 µs 20:33:43.759888 [debug] timer : scopedtimer.cpp:34 : parse_file "BIOTERROR_PROJECTOR.focs.txt" time: 2890 µs 20:33:43.760880 [debug] timer : scopedtimer.cpp:34 : parse_file "EXTINCT_KILANDOW.focs.txt" time: 1309 µs 20:33:43.761376 [debug] timer : scopedtimer.cpp:34 : parse_file "INTERSTELLAR_LOG.focs.txt" time: 2885 µs 20:33:43.761872 [debug] timer : scopedtimer.cpp:34 : parse_file "EXTINCT_MISIORLA.focs.txt" time: 1294 µs 20:33:43.762368 [debug] timer : scopedtimer.cpp:34 : parse_file "BLACK_HOLE_COLLAPSER.focs.txt" time: 2718 µs 20:33:43.762864 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_XENTRONIUM_PLATE.focs.txt" time: 3761 µs 20:33:43.763856 [debug] timer : scopedtimer.cpp:34 : parse_file "N_DIMEN_STRUCT.focs.txt" time: 2903 µs 20:33:43.765841 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_HEAVY_ASTEROID.focs.txt" time: 7440 µs 20:33:43.765841 [debug] timer : scopedtimer.cpp:34 : parse_file "ORBITAL_CON.focs.txt" time: 1946 µs 20:33:43.767328 [debug] timer : scopedtimer.cpp:34 : parse_file "BLACK_HOLE_POW_GEN.focs.txt" time: 4612 µs 20:33:43.767824 [debug] timer : scopedtimer.cpp:34 : parse_file "ORGANIC_STRUCT.focs.txt" time: 1878 µs 20:33:43.767824 [debug] timer : scopedtimer.cpp:34 : parse_file "AR_ZORTRIUM_PLATE.focs.txt" time: 5167 µs 20:33:43.768320 [debug] timer : scopedtimer.cpp:34 : parse_file "FORTRESS.focs.txt" time: 6382 µs 20:33:43.769808 [debug] timer : scopedtimer.cpp:34 : parse_file "PLANET_DRIVE.focs.txt" time: 2018 µs 20:33:43.770800 [debug] timer : scopedtimer.cpp:34 : parse_file "COLLECTIVE_NET.focs.txt" time: 3894 µs 20:33:43.771792 [debug] timer : scopedtimer.cpp:34 : parse_file "STARGATE.focs.txt" time: 1860 µs 20:33:43.772784 [debug] timer : scopedtimer.cpp:34 : parse_file "GAIA.focs.txt" time: 4431 µs 20:33:43.773280 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_MINIASTEROID_SWARM.focs.txt" time: 7424 µs 20:33:43.773776 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_BIOTERM.focs.txt" time: 5550 µs 20:33:43.773776 [debug] timer : scopedtimer.cpp:34 : parse_file "TRANSCEND_ARCH.focs.txt" time: 1947 µs 20:33:43.777744 [debug] timer : scopedtimer.cpp:34 : parse_file "CRYSTALS.focs.txt" time: 4715 µs 20:33:43.779232 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_CHAOS_WAVE.focs.txt" time: 5443 µs 20:33:43.779232 [debug] timer : scopedtimer.cpp:34 : parse_file "BarrierShield.focs.txt" time: 5456 µs 20:33:43.782704 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_ABADDONI.focs.txt" time: 11 ms 20:33:43.783696 [debug] timer : scopedtimer.cpp:34 : parse_file "ELERIUM.focs.txt" time: 6151 µs 20:33:43.783696 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_DARK_RAY.focs.txt" time: 4798 µs 20:33:43.785680 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SCATTERED_ASTEROID.focs.txt" time: 12 ms 20:33:43.788160 [debug] timer : scopedtimer.cpp:34 : parse_file "FRUIT.focs.txt" time: 4184 µs 20:33:43.788656 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_DEATH_SPORE.focs.txt" time: 4881 µs 20:33:43.792128 [debug] timer : scopedtimer.cpp:34 : parse_file "MINERALS.focs.txt" time: 4268 µs 20:33:43.793616 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_BANFORO.focs.txt" time: 10 ms 20:33:43.793616 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EMO.focs.txt" time: 4889 µs 20:33:43.795600 [debug] timer : scopedtimer.cpp:34 : parse_file "Defense.focs.txt" time: 16 ms 20:33:43.796096 [debug] timer : scopedtimer.cpp:34 : parse_file "MONOPOLE.focs.txt" time: 3928 µs 20:33:43.797584 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SMALL_ASTEROID.focs.txt" time: 11 ms 20:33:43.798576 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EMP.focs.txt" time: 4789 µs 20:33:43.800560 [debug] timer : scopedtimer.cpp:34 : parse_file "POSITRONIUM.focs.txt" time: 4222 µs 20:33:43.801056 [debug] timer : scopedtimer.cpp:34 : parse_file "Garrison.focs.txt" time: 5049 µs 20:33:43.804528 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_GRV.focs.txt" time: 5887 µs 20:33:43.804528 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_CHATO.focs.txt" time: 10 ms 20:33:43.805025 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_ACIREMA.focs.txt" time: 48 ms 20:33:43.805520 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SMALL_CAMOUFLAGE_ASTEROID.focs.txt" time: 8159 µs 20:33:43.806512 [debug] timer : scopedtimer.cpp:34 : parse_file "PROBIOTIC.focs.txt" time: 5863 µs 20:33:43.806512 [debug] timer : scopedtimer.cpp:34 : parse_file "Network.focs.txt" time: 5575 µs 20:33:43.808496 [debug] timer : scopedtimer.cpp:34 : parse_file "ADV_ECOMAN.focs.txt" time: 2225 µs 20:33:43.809488 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SONIC.focs.txt" time: 5188 µs 20:33:43.810976 [debug] timer : scopedtimer.cpp:34 : parse_file "SPICE.focs.txt" time: 4360 µs 20:33:43.811472 [debug] timer : scopedtimer.cpp:34 : parse_file "BIOTERROR.focs.txt" time: 2706 µs 20:33:43.813456 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_COMPRESSED_ENERGY.focs.txt" time: 7772 µs 20:33:43.814448 [debug] timer : scopedtimer.cpp:34 : parse_file "CYBORG.focs.txt" time: 2764 µs 20:33:43.814448 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_VOID_SHADOW.focs.txt" time: 4936 µs 20:33:43.814944 [debug] timer : scopedtimer.cpp:34 : parse_file "SUPERCONDUCTOR.focs.txt" time: 4216 µs 20:33:43.816432 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_CRAY.focs.txt" time: 11 ms 20:33:43.816928 [debug] timer : scopedtimer.cpp:34 : parse_file "HEAD_ON_A_SPIKE.focs.txt" time: 1843 µs 20:33:43.817424 [debug] timer : scopedtimer.cpp:34 : parse_file "ENERGY_META.focs.txt" time: 3072 µs 20:33:43.817920 [debug] timer : scopedtimer.cpp:34 : parse_file "CO_COLONY_POD.focs.txt" time: 3195 µs 20:33:43.818912 [debug] timer : scopedtimer.cpp:34 : parse_file "HIGH_TECH_NATIVES.focs.txt" time: 1992 µs 20:33:43.819904 [debug] timer : scopedtimer.cpp:34 : parse_file "CO_COL_OUTPOST.focs.txt" time: 1898 µs 20:33:43.819904 [debug] timer : scopedtimer.cpp:34 : parse_file "GAIA_TRANS.focs.txt" time: 2753 µs 20:33:43.820897 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_ENERGY_FRIGATE.focs.txt" time: 7533 µs 20:33:43.821888 [debug] timer : scopedtimer.cpp:34 : parse_file "GENETIC_ENG.focs.txt" time: 1850 µs 20:33:43.822384 [debug] timer : scopedtimer.cpp:34 : parse_file "HONEYCOMB.focs.txt" time: 3578 µs 20:33:43.822880 [debug] timer : scopedtimer.cpp:34 : parse_file "CO_SUPEND_ANIM_POD.focs.txt" time: 3207 µs 20:33:43.823872 [debug] timer : scopedtimer.cpp:34 : parse_file "GENETIC_MED.focs.txt" time: 1814 µs 20:33:43.823872 [debug] timer : scopedtimer.cpp:34 : parse_file "KRAKEN_IN_THE_ICE.focs.txt" time: 1571 µs 20:33:43.825856 [debug] timer : scopedtimer.cpp:34 : parse_file "LIFECYCLE_MAN.focs.txt" time: 2008 µs 20:33:43.825856 [debug] timer : scopedtimer.cpp:34 : parse_file "MODERATE_TECH_NATIVES.focs.txt" time: 1862 µs 20:33:43.827840 [debug] timer : scopedtimer.cpp:34 : parse_file "MEGA_ECO.focs.txt" time: 1834 µs 20:33:43.828336 [debug] timer : scopedtimer.cpp:34 : parse_file "JUGGERNAUT_NEST.focs.txt" time: 2399 µs 20:33:43.828832 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_FRACTAL_ENERGY.focs.txt" time: 7544 µs 20:33:43.828832 [debug] timer : scopedtimer.cpp:34 : parse_file "DT_DETECTOR_1.focs.txt" time: 6006 µs 20:33:43.829328 [debug] timer : scopedtimer.cpp:34 : parse_file "NANOTECH_MED.focs.txt" time: 1756 µs 20:33:43.830320 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_DERTHREAN.focs.txt" time: 14 ms 20:33:43.830816 [debug] timer : scopedtimer.cpp:34 : parse_file "KRAKEN_NEST.focs.txt" time: 2312 µs 20:33:43.831312 [debug] timer : scopedtimer.cpp:34 : parse_file "NANO_CYBERNET.focs.txt" time: 1799 µs 20:33:43.832800 [debug] timer : scopedtimer.cpp:34 : parse_file "DT_DETECTOR_2.focs.txt" time: 3729 µs 20:33:43.832800 [debug] timer : scopedtimer.cpp:34 : parse_file "SNOWFLAKE_NEST.focs.txt" time: 2281 µs 20:33:43.833792 [debug] timer : scopedtimer.cpp:34 : parse_file "ORBITAL_HAB.focs.txt" time: 2479 µs 20:33:43.834288 [debug] timer : scopedtimer.cpp:34 : parse_file "CLOUD_COVER_MASTER.focs.txt" time: 1369 µs 20:33:43.835776 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_QUANTUM_ENERGY.focs.txt" time: 7032 µs 20:33:43.836272 [debug] timer : scopedtimer.cpp:34 : parse_file "PLANETARY_ECOLOGY.focs.txt" time: 2368 µs 20:33:43.836272 [debug] timer : scopedtimer.cpp:34 : parse_file "DT_DETECTOR_3.focs.txt" time: 3607 µs 20:33:43.836272 [debug] timer : scopedtimer.cpp:34 : parse_file "CLOUD_COVER_SLAVE.focs.txt" time: 2090 µs 20:33:43.838752 [debug] timer : scopedtimer.cpp:34 : parse_file "SUBTER_HAB.focs.txt" time: 2364 µs 20:33:43.838752 [debug] timer : scopedtimer.cpp:34 : parse_file "DIM_RIFT_MASTER.focs.txt" time: 2248 µs 20:33:43.840240 [debug] timer : scopedtimer.cpp:34 : parse_file "DT_DETECTOR_4.focs.txt" time: 3670 µs 20:33:43.840240 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EAXAW.focs.txt" time: 10 ms 20:33:43.840736 [debug] timer : scopedtimer.cpp:34 : parse_file "DIM_RIFT_SLAVE.focs.txt" time: 2120 µs 20:33:43.840736 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_ANCIENT_GUARDIANS.focs.txt" time: 36 ms 20:33:43.841232 [debug] timer : scopedtimer.cpp:34 : parse_file "SYMBIOTIC_BIO.focs.txt" time: 2421 µs 20:33:43.842720 [debug] timer : scopedtimer.cpp:34 : parse_file "VOID_MASTER.focs.txt" time: 1817 µs 20:33:43.842720 [debug] timer : scopedtimer.cpp:34 : parse_file "TERRAFORM.focs.txt" time: 1840 µs 20:33:43.843712 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_BAY_1.focs.txt" time: 3346 µs 20:33:43.843712 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SOLAR.focs.txt" time: 7878 µs 20:33:43.844705 [debug] timer : scopedtimer.cpp:34 : parse_file "TRANSORG_SENT.focs.txt" time: 1821 µs 20:33:43.844705 [debug] timer : scopedtimer.cpp:34 : parse_file "VOID_SLAVE.focs.txt" time: 2098 µs 20:33:43.846688 [debug] timer : scopedtimer.cpp:34 : parse_file "VOLCANIC_ASH_MASTER.focs.txt" time: 1732 µs 20:33:43.846688 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_BAY_KRILL.focs.txt" time: 3372 µs 20:33:43.847184 [debug] timer : scopedtimer.cpp:34 : parse_file "XENO_GENETICS.focs.txt" time: 2595 µs 20:33:43.847680 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_BLACK_KRAKEN_BODY.focs.txt" time: 4096 µs 20:33:43.848672 [debug] timer : scopedtimer.cpp:34 : parse_file "VOLCANIC_ASH_SLAVE.focs.txt" time: 2159 µs 20:33:43.850160 [debug] timer : scopedtimer.cpp:34 : parse_file "XENO_HYBRIDS.focs.txt" time: 2547 µs 20:33:43.850160 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_HANGAR_0.focs.txt" time: 3331 µs 20:33:43.850656 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EGASSEM.focs.txt" time: 10 ms 20:33:43.851153 [debug] timer : scopedtimer.cpp:34 : parse_file "PANOPTICON.focs.txt" time: 2363 µs 20:33:43.851648 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_BLOATED_JUGGERNAUT_BODY.focs.txt" time: 3963 µs 20:33:43.852641 [debug] timer : scopedtimer.cpp:34 : parse_file "ALGO_ELEGANCE.focs.txt" time: 2485 µs 20:33:43.853633 [debug] timer : scopedtimer.cpp:34 : parse_file "PHILOSOPHER.focs.txt" time: 2481 µs 20:33:43.854128 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_HANGAR_1.focs.txt" time: 3938 µs 20:33:43.854625 [debug] timer : scopedtimer.cpp:34 : parse_file "ARTIF_MINDS.focs.txt" time: 2384 µs 20:33:43.855616 [debug] timer : scopedtimer.cpp:34 : parse_file "RESONANT_MOON.focs.txt" time: 1853 µs 20:33:43.856112 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_COSMIC_DRAGON_BODY.focs.txt" time: 4218 µs 20:33:43.856608 [debug] timer : scopedtimer.cpp:34 : parse_file "ART_BLACK_HOLE.focs.txt" time: 1775 µs 20:33:43.857600 [debug] timer : scopedtimer.cpp:34 : parse_file "SCRYING_SPHERE.focs.txt" time: 1770 µs 20:33:43.857600 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_HANGAR_2.focs.txt" time: 3552 µs 20:33:43.858591 [debug] timer : scopedtimer.cpp:34 : parse_file "COLLAPSER.focs.txt" time: 1833 µs 20:33:43.860080 [debug] timer : scopedtimer.cpp:34 : parse_file "TEMPORAL_ANOMOLY.focs.txt" time: 2411 µs 20:33:43.860576 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_DAMPENING_CLOUD_BODY.focs.txt" time: 4491 µs 20:33:43.861072 [debug] timer : scopedtimer.cpp:34 : parse_file "DISTRIB_THOUGHT.focs.txt" time: 2345 µs 20:33:43.861072 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_ETTY.focs.txt" time: 10 ms 20:33:43.861072 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_HANGAR_3.focs.txt" time: 3394 µs 20:33:43.862065 [debug] timer : scopedtimer.cpp:34 : parse_file "TIDAL_LOCK.focs.txt" time: 2068 µs 20:33:43.862560 [debug] timer : scopedtimer.cpp:34 : parse_file "ENCLAVE_VOID.focs.txt" time: 1809 µs 20:33:43.864048 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_DRONE_BODY.focs.txt" time: 3357 µs 20:33:43.864545 [debug] timer : scopedtimer.cpp:34 : parse_file "WORLDTREE.focs.txt" time: 2426 µs 20:33:43.864545 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_HANGAR_4.focs.txt" time: 3374 µs 20:33:43.864545 [debug] timer : scopedtimer.cpp:34 : parse_file "EVERYTHING.focs.txt" time: 1969 µs 20:33:43.866528 [debug] timer : scopedtimer.cpp:34 : parse_file "SUPERNOVA.focs.txt" time: 2080 µs 20:33:43.867024 [debug] timer : scopedtimer.cpp:34 : parse_file "FORCE_FIELD.focs.txt" time: 2364 µs 20:33:43.867520 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_EXP_OUTPOST_HULL.focs.txt" time: 3841 µs 20:33:43.868017 [debug] timer : scopedtimer.cpp:34 : parse_file "FT_HANGAR_KRILL.focs.txt" time: 3359 µs 20:33:43.868513 [debug] timer : scopedtimer.cpp:34 : parse_file "ACCRETION_DISC.focs.txt" time: 1951 µs 20:33:43.868513 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EXOBOT.focs.txt" time: 7497 µs 20:33:43.869009 [debug] timer : scopedtimer.cpp:34 : parse_file "GATEWAY_VOID.focs.txt" time: 1779 µs 20:33:43.870496 [debug] timer : scopedtimer.cpp:34 : parse_file "DERELICT_2.focs.txt" time: 2211 µs 20:33:43.870496 [debug] timer : scopedtimer.cpp:34 : parse_file "GRAVITONICS.focs.txt" time: 1803 µs 20:33:43.871489 [debug] timer : scopedtimer.cpp:34 : parse_file "FU_BASIC_TANK.focs.txt" time: 3295 µs 20:33:43.871489 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_FLOATER.focs.txt" time: 3741 µs 20:33:43.872481 [debug] timer : scopedtimer.cpp:34 : parse_file "MIND_VOID.focs.txt" time: 1910 µs 20:33:43.872977 [debug] timer : scopedtimer.cpp:34 : parse_file "DERELICT_3.focs.txt" time: 2189 µs 20:33:43.874464 [debug] timer : scopedtimer.cpp:34 : parse_file "N_DIM_SUBSPACE.focs.txt" time: 1805 µs 20:33:43.874464 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_GUARD_0_BODY.focs.txt" time: 3106 µs 20:33:43.874960 [debug] timer : scopedtimer.cpp:34 : parse_file "FU_RAMSCOOP.focs.txt" time: 3396 µs 20:33:43.876449 [debug] timer : scopedtimer.cpp:34 : parse_file "PHYSICAL_BRAIN.focs.txt" time: 1780 µs 20:33:43.876449 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_BANFORO.focs.txt" time: 35 ms 20:33:43.877936 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_GUARD_1_BODY.focs.txt" time: 3054 µs 20:33:43.877936 [debug] timer : scopedtimer.cpp:34 : parse_file "FU_ZERO_FUEL.focs.txt" time: 3373 µs 20:33:43.878432 [debug] timer : scopedtimer.cpp:34 : parse_file "PSIONICS.focs.txt" time: 2020 µs 20:33:43.878928 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_FULVER.focs.txt" time: 10 ms 20:33:43.880417 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_ASH.focs.txt" time: 2149 µs 20:33:43.880913 [debug] timer : scopedtimer.cpp:34 : parse_file "PSY_DOM.focs.txt" time: 2647 µs 20:33:43.881409 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_GUARD_3_BODY.focs.txt" time: 3618 µs 20:33:43.882400 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_CLOUD.focs.txt" time: 2121 µs 20:33:43.883392 [debug] timer : scopedtimer.cpp:34 : parse_file "QUANT_NET.focs.txt" time: 2513 µs 20:33:43.884384 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_DIM.focs.txt" time: 2134 µs 20:33:43.884881 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_GUARD_MONSTER_BODY.focs.txt" time: 3508 µs 20:33:43.885377 [debug] timer : scopedtimer.cpp:34 : parse_file "SPATIAL_DISTORT_GEN.focs.txt" time: 1793 µs 20:33:43.888352 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_DISTORTION_MODULATOR.focs.txt" time: 3493 µs 20:33:43.888352 [debug] timer : scopedtimer.cpp:34 : parse_file "STELLAR_TOMOGRAPHY.focs.txt" time: 3071 µs 20:33:43.888352 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_IMMOBILE_FACTOR.focs.txt" time: 3568 µs 20:33:43.889345 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_FURTHEST.focs.txt" time: 10 ms 20:33:43.890336 [debug] timer : scopedtimer.cpp:34 : parse_file "TEMPORAL_MECH.focs.txt" time: 1806 µs 20:33:43.892320 [debug] timer : scopedtimer.cpp:34 : parse_file "TRANSCEND.focs.txt" time: 2024 µs 20:33:43.892320 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_KRILL_SPAWNER.focs.txt" time: 4207 µs 20:33:43.893312 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_JUGGERNAUT_1_BODY.focs.txt" time: 4672 µs 20:33:43.894304 [debug] timer : scopedtimer.cpp:34 : parse_file "TRANSLING_THOUGHT.focs.txt" time: 1826 µs 20:33:43.895793 [debug] timer : scopedtimer.cpp:34 : parse_file "UNIFIED_CONC.focs.txt" time: 1801 µs 20:33:43.896785 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_NOVA_BOMB.focs.txt" time: 4152 µs 20:33:43.897281 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_JUGGERNAUT_2_BODY.focs.txt" time: 4036 µs 20:33:43.897776 [debug] timer : scopedtimer.cpp:34 : parse_file "XENO_ARCH.focs.txt" time: 1775 µs 20:33:43.899761 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_GEORGE.focs.txt" time: 10 ms 20:33:43.899761 [debug] timer : scopedtimer.cpp:34 : parse_file "EXOBOTS.focs.txt" time: 1789 µs 20:33:43.899761 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_PLANET_BEACON.focs.txt" time: 3284 µs 20:33:43.900753 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_JUGGERNAUT_3_BODY.focs.txt" time: 3433 µs 20:33:43.902241 [debug] timer : scopedtimer.cpp:34 : parse_file "FUSION_GEN.focs.txt" time: 2430 µs 20:33:43.904721 [debug] timer : scopedtimer.cpp:34 : parse_file "GENERIC_SUPPLIES.focs.txt" time: 2368 µs 20:33:43.905217 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_KRAKEN_1_BODY.focs.txt" time: 4619 µs 20:33:43.906208 [debug] timer : scopedtimer.cpp:34 : parse_file "INDUSTRY_CENTER_I.focs.txt" time: 1780 µs 20:33:43.908193 [debug] timer : scopedtimer.cpp:34 : parse_file "INDUSTRY_CENTER_II.focs.txt" time: 1769 µs 20:33:43.909185 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_BEIGEGOO.focs.txt" time: 33 ms 20:33:43.909681 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_KRAKEN_2_BODY.focs.txt" time: 4322 µs 20:33:43.909681 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_GYSACHE.focs.txt" time: 10 ms 20:33:43.909681 [debug] timer : scopedtimer.cpp:34 : parse_file "INDUSTRY_CENTER_III.focs.txt" time: 1762 µs 20:33:43.913152 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_KRAKEN_3_BODY.focs.txt" time: 3537 µs 20:33:43.913648 [debug] timer : scopedtimer.cpp:34 : parse_file "INTERSTELLAR_ENTANGLEMENT_FACTORY.focs.txt" time: 3905 µs 20:33:43.916624 [debug] timer : scopedtimer.cpp:34 : parse_file "MICRO_MANUF.focs.txt" time: 2675 µs 20:33:43.918112 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_KRILL_1_BODY.focs.txt" time: 4732 µs 20:33:43.918112 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SOLAR_CONCENTRATOR.focs.txt" time: 18 ms 20:33:43.918112 [debug] timer : scopedtimer.cpp:34 : parse_file "NANOTECH_PROD.focs.txt" time: 1787 µs 20:33:43.920096 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_HAPPY.focs.txt" time: 10 ms 20:33:43.920096 [debug] timer : scopedtimer.cpp:34 : parse_file "NEUTRONIUM_EXTRACTION.focs.txt" time: 1869 µs 20:33:43.920592 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_VOID.focs.txt" time: 2115 µs 20:33:43.922080 [debug] timer : scopedtimer.cpp:34 : parse_file "N_DIM_ASSEM.focs.txt" time: 1807 µs 20:33:43.922576 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_KRILL_2_BODY.focs.txt" time: 4715 µs 20:33:43.924064 [debug] timer : scopedtimer.cpp:34 : parse_file "ORBITAL_GEN.focs.txt" time: 1811 µs 20:33:43.924064 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_BLACK.focs.txt" time: 3757 µs 20:33:43.926048 [debug] timer : scopedtimer.cpp:34 : parse_file "PREDICTIVE_STOCKPILING.focs.txt" time: 2050 µs 20:33:43.927536 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_KRILL_3_BODY.focs.txt" time: 4732 µs 20:33:43.928032 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_DEFENSE_GRID.focs.txt" time: 3601 µs 20:33:43.928528 [debug] timer : scopedtimer.cpp:34 : parse_file "ROBOTIC_PROD.focs.txt" time: 2330 µs 20:33:43.930512 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_HHHOH.focs.txt" time: 10 ms 20:33:43.930512 [debug] timer : scopedtimer.cpp:34 : parse_file "SENTIENT_AUTOMATION.focs.txt" time: 2363 µs 20:33:43.931008 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_KRILL_4_BODY.focs.txt" time: 3668 µs 20:33:43.931504 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_DEFLECTOR.focs.txt" time: 3670 µs 20:33:43.932496 [debug] timer : scopedtimer.cpp:34 : parse_file "SINGULAR_GEN.focs.txt" time: 1814 µs 20:33:43.934480 [debug] timer : scopedtimer.cpp:34 : parse_file "SOLAR_ORB_GEN.focs.txt" time: 1783 µs 20:33:43.934480 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_NEBULOUS.focs.txt" time: 3197 µs 20:33:43.935472 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_MULTISPEC.focs.txt" time: 3775 µs 20:33:43.935968 [debug] timer : scopedtimer.cpp:34 : parse_file "TRANS_DESIGN.focs.txt" time: 1828 µs 20:33:43.938448 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_PSIONIC_SNOWFLAKE_BODY.focs.txt" time: 4126 µs 20:33:43.938944 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_PLASMA.focs.txt" time: 3569 µs 20:33:43.939440 [debug] timer : scopedtimer.cpp:34 : parse_file "VOID_PREDICTION.focs.txt" time: 3208 µs 20:33:43.940432 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_HUMAN.focs.txt" time: 9935 µs 20:33:43.941424 [debug] timer : scopedtimer.cpp:34 : parse_file "ZERO_GEN.focs.txt" time: 1793 µs 20:33:43.942416 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_CHATO.focs.txt" time: 33 ms 20:33:43.942912 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SNOWFLAKE_1_BODY.focs.txt" time: 4314 µs 20:33:43.942912 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ASTEROID_HULLS.focs.txt" time: 1851 µs 20:33:43.944896 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ASTEROID_REFORM.focs.txt" time: 1876 µs 20:33:43.945392 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_ROBOTIC_INTERFACE_SHIELDS.focs.txt" time: 6571 µs 20:33:43.946880 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_CAMO_AST_HULL.focs.txt" time: 1879 µs 20:33:43.946880 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SNOWFLAKE_2_BODY.focs.txt" time: 4083 µs 20:33:43.948864 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_HEAVY_AST_HULL.focs.txt" time: 1882 µs 20:33:43.949360 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_ICE_BEAM.focs.txt" time: 3633 µs 20:33:43.950352 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SNOWFLAKE_3_BODY.focs.txt" time: 3487 µs 20:33:43.950848 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MINIAST_SWARM.focs.txt" time: 1812 µs 20:33:43.950848 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_KILANDOW.focs.txt" time: 10 ms 20:33:43.952336 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MONOMOLEC_LATTIC.focs.txt" time: 1830 µs 20:33:43.952832 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_JAWS.focs.txt" time: 3576 µs 20:33:43.953824 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_STRONG_MONSTER_BODY.focs.txt" time: 3317 µs 20:33:43.954320 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SCAT_AST_HULL.focs.txt" time: 1926 µs 20:33:43.956304 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ENRG_BOUND_MAN.focs.txt" time: 1904 µs 20:33:43.956304 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_PLASMA_DISCHARGE.focs.txt" time: 3609 µs 20:33:43.957296 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_TREE_BODY.focs.txt" time: 3519 µs 20:33:43.958288 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ENRG_FRIGATE.focs.txt" time: 1834 µs 20:33:43.960272 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_FRC_ENRG_COMP.focs.txt" time: 1832 µs 20:33:43.960272 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_SPINAL_ANTIMATTER.focs.txt" time: 3714 µs 20:33:43.960272 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_WHITE_KRAKEN_BODY.focs.txt" time: 2984 µs 20:33:43.961264 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_KOBUNTURA.focs.txt" time: 10 ms 20:33:43.961760 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_QUANT_ENRG_MAG.focs.txt" time: 1838 µs 20:33:43.963744 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_SPINES.focs.txt" time: 3596 µs 20:33:43.963744 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SOLAR_CONT.focs.txt" time: 1826 µs 20:33:43.965728 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_BIOADAPTIVE_SPEC.focs.txt" time: 1836 µs 20:33:43.967216 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_TENTACLE.focs.txt" time: 3558 µs 20:33:43.967712 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_CONT_BIOADAPT.focs.txt" time: 1813 µs 20:33:43.967712 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_BIOADAPTIVE.focs.txt" time: 7456 µs 20:33:43.969200 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_CONT_SYMB.focs.txt" time: 1829 µs 20:33:43.971184 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_LAENFA.focs.txt" time: 9924 µs 20:33:43.971184 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ENDOCRINE_SYSTEMS.focs.txt" time: 1806 µs 20:33:43.971184 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_WEAPON_0_1.focs.txt" time: 3843 µs 20:33:43.973168 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ENDOSYMB_HULL.focs.txt" time: 1840 µs 20:33:43.975152 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MONOCELL_EXP.focs.txt" time: 1840 µs 20:33:43.975152 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_ENDOMORPHIC.focs.txt" time: 7321 µs 20:33:43.975152 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_WEAPON_1_1.focs.txt" time: 4010 µs 20:33:43.975648 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_CRAY.focs.txt" time: 32 ms 20:33:43.976640 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MULTICELL_CAST.focs.txt" time: 1851 µs 20:33:43.978624 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ORG_HULL.focs.txt" time: 1844 µs 20:33:43.979120 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_WEAPON_2_1.focs.txt" time: 3807 µs 20:33:43.980608 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SENT_HULL.focs.txt" time: 1847 µs 20:33:43.981600 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_MISIORLA.focs.txt" time: 10 ms 20:33:43.982592 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_CONTGRAV_MAINT.focs.txt" time: 1837 µs 20:33:43.982592 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_ENDOSYMBIOTIC.focs.txt" time: 7530 µs 20:33:43.983088 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_WEAPON_3_1.focs.txt" time: 3812 µs 20:33:43.984080 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MASSPROP_SPEC.focs.txt" time: 1855 µs 20:33:43.986064 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MIDCOMB_LOG.focs.txt" time: 1874 µs 20:33:43.986560 [debug] timer : scopedtimer.cpp:34 : parse_file "SR_WEAPON_4_1.focs.txt" time: 3844 µs 20:33:43.988048 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MIL_ROBO_CONT.focs.txt" time: 1822 µs 20:33:43.990032 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_NANOROBO_MAINT.focs.txt" time: 1817 µs 20:33:43.990032 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_ORGANIC.focs.txt" time: 7269 µs 20:33:43.990032 [debug] timer : scopedtimer.cpp:34 : parse_file "FU_IMPROVED_ENGINE_COUPLINGS.focs.txt" time: 3360 µs 20:33:43.991520 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SPACE_FLUX_BUBBLE.focs.txt" time: 1816 µs 20:33:43.992016 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_MUURSH.focs.txt" time: 10 ms 20:33:43.993504 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SPACE_FLUX_DRIVE.focs.txt" time: 1834 µs 20:33:43.993504 [debug] timer : scopedtimer.cpp:34 : parse_file "FU_N_DIMENSIONAL_ENGINE_MATRIX.focs.txt" time: 3529 µs 20:33:43.995488 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_TRANSSPACE_DRIVE.focs.txt" time: 1851 µs 20:33:43.996976 [debug] timer : scopedtimer.cpp:34 : parse_file "FU_SINGULARITY_ENGINE_CORE.focs.txt" time: 3360 µs 20:33:43.996976 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_DOMESTIC_MONSTER.focs.txt" time: 1766 µs 20:33:43.997472 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_PROTOPLASMIC.focs.txt" time: 7576 µs 20:33:44.001440 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_GAL_EXPLO.focs.txt" time: 4432 µs 20:33:44.001936 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_PHINNERT.focs.txt" time: 9922 µs 20:33:44.002432 [debug] timer : scopedtimer.cpp:34 : parse_file "FU_TRANSPATIAL_DRIVE.focs.txt" time: 5251 µs 20:33:44.003424 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_XENTRONIUM_HULL.focs.txt" time: 1800 µs 20:33:44.004912 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_RAVENOUS.focs.txt" time: 7288 µs 20:33:44.005408 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_DIAMOND_PLATE.focs.txt" time: 1790 µs 20:33:44.005904 [debug] timer : scopedtimer.cpp:34 : parse_file "ST_CLOAK_1.focs.txt" time: 3556 µs 20:33:44.006896 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ROOT_ARMOR.focs.txt" time: 1733 µs 20:33:44.007392 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_CYNOS.focs.txt" time: 32 ms 20:33:44.008880 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_XENTRONIUM_PLATE.focs.txt" time: 1787 µs 20:33:44.009872 [debug] timer : scopedtimer.cpp:34 : parse_file "ST_CLOAK_2.focs.txt" time: 3744 µs 20:33:44.010864 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ZORTRIUM_PLATE.focs.txt" time: 1815 µs 20:33:44.011856 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_REPLICON.focs.txt" time: 9892 µs 20:33:44.012848 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ADV_DAM_CONT.focs.txt" time: 2034 µs 20:33:44.012848 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SENTIENT.focs.txt" time: 7833 µs 20:33:44.013344 [debug] timer : scopedtimer.cpp:34 : parse_file "ST_CLOAK_3.focs.txt" time: 3589 µs 20:33:44.014832 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_BASIC_DAM_CONT.focs.txt" time: 2118 µs 20:33:44.016816 [debug] timer : scopedtimer.cpp:34 : parse_file "ST_CLOAK_4.focs.txt" time: 3630 µs 20:33:44.016816 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_FLEET_REPAIR.focs.txt" time: 2084 µs 20:33:44.019297 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_REINFORCED_HULL.focs.txt" time: 1992 µs 20:33:44.020288 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_STATIC_MULTICELLULAR.focs.txt" time: 7291 µs 20:33:44.020784 [debug] timer : scopedtimer.cpp:34 : parse_file "GT_TROOP_POD.focs.txt" time: 3510 µs 20:33:44.021280 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ANTIMATTER_TANK.focs.txt" time: 2415 µs 20:33:44.022272 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SCYLIOR.focs.txt" time: 10 ms 20:33:44.023760 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_DEUTERIUM_TANK.focs.txt" time: 2374 µs 20:33:44.024256 [debug] timer : scopedtimer.cpp:34 : parse_file "GT_TROOP_POD_2.focs.txt" time: 3579 µs 20:33:44.025744 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ZERO_POINT.focs.txt" time: 1944 µs 20:33:44.027233 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SYMBIOTIC.focs.txt" time: 7244 µs 20:33:44.027728 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_BLACKSHIELD.focs.txt" time: 1780 µs 20:33:44.029712 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_DEFLECTOR_SHIELD.focs.txt" time: 1783 µs 20:33:44.031201 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_MULTISPEC_SHIELD.focs.txt" time: 1765 µs 20:33:44.031696 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SETINON.focs.txt" time: 9856 µs 20:33:44.033184 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_PLASMA_SHIELD.focs.txt" time: 1752 µs 20:33:44.034672 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_IMPROVED_ENGINE_COUPLINGS.focs.txt" time: 1802 µs 20:33:44.035664 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_LOGITICS_FACILITATOR.focs.txt" time: 8363 µs 20:33:44.036656 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_N_DIMENSIONAL_ENGINE_MATRIX.focs.txt" time: 1802 µs 20:33:44.038640 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SINGULATIRY_ENGINE_CORE.focs.txt" time: 1825 µs 20:33:44.040128 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_BIOTERM.focs.txt" time: 1760 µs 20:33:44.040624 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_DERTHREAN.focs.txt" time: 33 ms 20:33:44.042113 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SILEXIAN.focs.txt" time: 10 ms 20:33:44.042113 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_BOMBARD.focs.txt" time: 1741 µs 20:33:44.043104 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_NANOROBOTIC.focs.txt" time: 7202 µs 20:33:44.044096 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_CHAOS_WAVE.focs.txt" time: 1864 µs 20:33:44.046080 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_DARK_RAY.focs.txt" time: 1905 µs 20:33:44.047568 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_DEATH_SPORE.focs.txt" time: 1796 µs 20:33:44.049552 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_EMO.focs.txt" time: 1770 µs 20:33:44.050544 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_ROBOTIC.focs.txt" time: 7432 µs 20:33:44.051536 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_EMP.focs.txt" time: 1802 µs 20:33:44.052528 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SLY.focs.txt" time: 10 ms 20:33:44.053025 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_GRV.focs.txt" time: 1839 µs 20:33:44.055008 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SONIC.focs.txt" time: 1797 µs 20:33:44.056992 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_VOID_SHADOW.focs.txt" time: 1781 µs 20:33:44.057488 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SELF_GRAVITATING.focs.txt" time: 7071 µs 20:33:44.058480 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_FIGHTERS_1.focs.txt" time: 1823 µs 20:33:44.060960 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_FIGHTERS_2.focs.txt" time: 2128 µs 20:33:44.062945 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SSLITH.focs.txt" time: 10 ms 20:33:44.062945 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_FIGHTERS_3.focs.txt" time: 2086 µs 20:33:44.064928 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SPACE_FLUX_BUBBLE.focs.txt" time: 7264 µs 20:33:44.064928 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_FIGHTERS_4.focs.txt" time: 2118 µs 20:33:44.066913 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ORGANIC_WAR_ADAPTION.focs.txt" time: 1828 µs 20:33:44.068896 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SOLAR_CONNECTION.focs.txt" time: 1749 µs 20:33:44.070385 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_SPINAL_ANTIMATTER.focs.txt" time: 1775 µs 20:33:44.072368 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_SPATIAL_FLUX.focs.txt" time: 7394 µs 20:33:44.073360 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SUPER_TEST.focs.txt" time: 10 ms 20:33:44.073360 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_1_2.focs.txt" time: 2712 µs 20:33:44.076336 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EAXAW.focs.txt" time: 35 ms 20:33:44.076336 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_1_3.focs.txt" time: 2850 µs 20:33:44.078816 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_1_4.focs.txt" time: 2758 µs 20:33:44.079312 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_TITANIC.focs.txt" time: 7131 µs 20:33:44.081793 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_2_1.focs.txt" time: 2961 µs 20:33:44.083281 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_TAEGHIRUS.focs.txt" time: 10 ms 20:33:44.084769 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_2_2.focs.txt" time: 2745 µs 20:33:44.086257 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_TRANSSPATIAL.focs.txt" time: 6972 µs 20:33:44.087249 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_2_3.focs.txt" time: 2789 µs 20:33:44.090225 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_2_4.focs.txt" time: 2850 µs 20:33:44.092705 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_BASIC_LARGE.focs.txt" time: 6429 µs 20:33:44.093201 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_3_1.focs.txt" time: 2879 µs 20:33:44.093697 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_TRITH.focs.txt" time: 10 ms 20:33:44.096177 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_3_2.focs.txt" time: 2813 µs 20:33:44.098657 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_3_3.focs.txt" time: 2727 µs 20:33:44.099153 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_BASIC_MEDIUM.focs.txt" time: 6414 µs 20:33:44.101633 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_3_4.focs.txt" time: 2740 µs 20:33:44.103617 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_UGMORS.focs.txt" time: 9910 µs 20:33:44.104609 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_4_1.focs.txt" time: 2845 µs 20:33:44.105601 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_BASIC_SMALL.focs.txt" time: 6321 µs 20:33:44.105601 [debug] timer : scopedtimer.cpp:34 : parse_file "COLONY_BASE.focs.txt" time: 2293 µs 20:33:44.107089 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_4_2.focs.txt" time: 2695 µs 20:33:44.108081 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_COLONY_BASE.focs.txt" time: 2367 µs 20:33:44.109073 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EGASSEM.focs.txt" time: 32 ms 20:33:44.110065 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_4_3.focs.txt" time: 2793 µs 20:33:44.111553 [debug] timer : scopedtimer.cpp:34 : parse_file "CONC_CAMP.focs.txt" time: 5725 µs 20:33:44.113041 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_WEAPON_4_4.focs.txt" time: 2853 µs 20:33:44.113537 [debug] timer : scopedtimer.cpp:34 : parse_file "CONC_CAMP_REMNANT.focs.txt" time: 1905 µs 20:33:44.114529 [debug] timer : scopedtimer.cpp:34 : parse_file "SH_XENTRONIUM.focs.txt" time: 6370 µs 20:33:44.114529 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_KRILL_SPAWN.focs.txt" time: 1779 µs 20:33:44.116513 [debug] timer : scopedtimer.cpp:34 : parse_file "CULTURE_ARCHIVES.focs.txt" time: 2803 µs 20:33:44.116513 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_NOVA_BOMB.focs.txt" time: 1801 µs 20:33:44.118993 [debug] timer : scopedtimer.cpp:34 : parse_file "CULTURE_LIBRARY.focs.txt" time: 2489 µs 20:33:44.119985 [debug] timer : scopedtimer.cpp:34 : parse_file "SHP_ROOT_AGGRESSION.focs.txt" time: 3238 µs 20:33:44.121473 [debug] timer : scopedtimer.cpp:34 : parse_file "COL_BANFORO.focs.txt" time: 1433 µs 20:33:44.121969 [debug] timer : scopedtimer.cpp:34 : parse_file "ENCLAVE_VOID.focs.txt" time: 2968 µs 20:33:44.122465 [debug] timer : scopedtimer.cpp:34 : parse_file "COL_KILANDOW.focs.txt" time: 1414 µs 20:33:44.123953 [debug] timer : scopedtimer.cpp:34 : parse_file "COL_MISIORLA.focs.txt" time: 1424 µs 20:33:44.126928 [debug] timer : scopedtimer.cpp:34 : parse_file "EVACUATION.focs.txt" time: 5062 µs 20:33:44.130401 [debug] timer : scopedtimer.cpp:34 : parse_file "CUSTOM_ADVISORIES.focs.txt" time: 6262 µs 20:33:44.132385 [debug] timer : scopedtimer.cpp:34 : parse_file "DETECT_1.focs.txt" time: 1928 µs 20:33:44.134369 [debug] timer : scopedtimer.cpp:34 : parse_file "DETECT_2.focs.txt" time: 2215 µs 20:33:44.136849 [debug] timer : scopedtimer.cpp:34 : parse_file "DETECT_3.focs.txt" time: 2120 µs 20:33:44.138833 [debug] timer : scopedtimer.cpp:34 : parse_file "DETECT_4.focs.txt" time: 1998 µs 20:33:44.140817 [debug] timer : scopedtimer.cpp:34 : parse_file "DETECT_5.focs.txt" time: 1906 µs 20:33:44.142305 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_ETTY.focs.txt" time: 33 ms 20:33:44.142305 [debug] timer : scopedtimer.cpp:34 : parse_file "DISTORT_MODU.focs.txt" time: 1751 µs 20:33:44.144289 [debug] timer : scopedtimer.cpp:34 : parse_file "FORCE_ENERGY_CAMO.focs.txt" time: 1851 µs 20:33:44.146273 [debug] timer : scopedtimer.cpp:34 : parse_file "LIGHTHOUSE.focs.txt" time: 1787 µs 20:33:44.148257 [debug] timer : scopedtimer.cpp:34 : parse_file "PLANET_STEALTH_MOD.focs.txt" time: 1883 µs 20:33:44.149249 [debug] timer : scopedtimer.cpp:34 : parse_file "ROOT_DECEPTION.focs.txt" time: 1396 µs 20:33:44.151729 [debug] timer : scopedtimer.cpp:34 : parse_file "STEALTH_1.focs.txt" time: 2184 µs 20:33:44.153217 [debug] timer : scopedtimer.cpp:34 : parse_file "EXPERIMENTOR_OUTPOST.focs.txt" time: 26 ms 20:33:44.153713 [debug] timer : scopedtimer.cpp:34 : parse_file "STEALTH_2.focs.txt" time: 2183 µs 20:33:44.156193 [debug] timer : scopedtimer.cpp:34 : parse_file "STEALTH_3.focs.txt" time: 2173 µs 20:33:44.156193 [debug] timer : scopedtimer.cpp:34 : parse_file "GAIA_TRANS.focs.txt" time: 3078 µs 20:33:44.158177 [debug] timer : scopedtimer.cpp:34 : parse_file "STEALTH_4.focs.txt" time: 2015 µs 20:33:44.159665 [debug] timer : scopedtimer.cpp:34 : parse_file "GAS_GIANT_GEN.focs.txt" time: 3509 µs 20:33:44.159665 [debug] timer : scopedtimer.cpp:34 : parse_file "STEALTH_PART_1.focs.txt" time: 1764 µs 20:33:44.161649 [debug] timer : scopedtimer.cpp:34 : parse_file "STEALTH_PART_2.focs.txt" time: 1778 µs 20:33:44.163137 [debug] timer : scopedtimer.cpp:34 : parse_file "GATEWAY_VOID.focs.txt" time: 3431 µs 20:33:44.163633 [debug] timer : scopedtimer.cpp:34 : parse_file "STEALTH_PART_3.focs.txt" time: 1756 µs 20:33:44.165617 [debug] timer : scopedtimer.cpp:34 : parse_file "GENOME_BANK.focs.txt" time: 2427 µs 20:33:44.169585 [debug] timer : scopedtimer.cpp:34 : parse_file "HYPER_DAM.focs.txt" time: 3658 µs 20:33:44.173553 [debug] timer : scopedtimer.cpp:34 : parse_file "IMPERIAL_PALACE.focs.txt" time: 4201 µs 20:33:44.174545 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EXOBOT.focs.txt" time: 32 ms 20:33:44.177521 [debug] timer : scopedtimer.cpp:34 : parse_file "INDUSTRY_CENTER.focs.txt" time: 3833 µs 20:33:44.181985 [debug] timer : scopedtimer.cpp:34 : parse_file "INTERSPECIES_ACADEMY.focs.txt" time: 4631 µs 20:33:44.184961 [debug] timer : scopedtimer.cpp:34 : parse_file "LIGHTHOUSE.focs.txt" time: 2762 µs 20:33:44.188433 [debug] timer : scopedtimer.cpp:34 : parse_file "MEGALITH.focs.txt" time: 3475 µs 20:33:44.191409 [debug] timer : scopedtimer.cpp:34 : parse_file "NEST_ERADICATOR.focs.txt" time: 3094 µs 20:33:44.193889 [debug] timer : scopedtimer.cpp:34 : parse_file "NEUTRONIUM_EXTRACTOR.focs.txt" time: 2471 µs 20:33:44.196865 [debug] timer : scopedtimer.cpp:34 : parse_file "NEUTRONIUM_FORGE.focs.txt" time: 2755 µs 20:33:44.198849 [debug] timer : scopedtimer.cpp:34 : parse_file "NEUTRONIUM_SYNTH.focs.txt" time: 1872 µs 20:33:44.200337 [debug] timer : scopedtimer.cpp:34 : parse_file "NOVA_BOMB_ACTIVATOR.focs.txt" time: 1763 µs 20:33:44.202817 [debug] timer : scopedtimer.cpp:34 : parse_file "PLANET_BEACON.focs.txt" time: 2504 µs 20:33:44.205297 [debug] timer : scopedtimer.cpp:34 : parse_file "PLANET_CLOAK.focs.txt" time: 2381 µs 20:33:44.206785 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_EXPERIMENTOR.focs.txt" time: 32 ms 20:33:44.208273 [debug] timer : scopedtimer.cpp:34 : parse_file "PLANET_DRIVE.focs.txt" time: 2564 µs 20:33:44.210752 [debug] timer : scopedtimer.cpp:34 : parse_file "SCANNING_FACILITY.focs.txt" time: 2760 µs 20:33:44.213233 [debug] timer : scopedtimer.cpp:34 : parse_file "SCRYING_SPHERE.focs.txt" time: 2450 µs 20:33:44.215713 [debug] timer : scopedtimer.cpp:34 : parse_file "ASTEROID.focs.txt" time: 2603 µs 20:33:44.218689 [debug] timer : scopedtimer.cpp:34 : parse_file "ASTEROID_REF.focs.txt" time: 2641 µs 20:33:44.221169 [debug] timer : scopedtimer.cpp:34 : parse_file "BASE.focs.txt" time: 2723 µs 20:33:44.222161 [debug] client : gamerules.cpp:188 : Registered and Parsed Game Rules: 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_STARLANES_EVERYWHERE : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_RESEED_PRNG_SERVER : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_ENABLE_EXPERIMENTORS : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_STOCKPILE_IMPORT_LIMITED : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_CHEAP_AND_FAST_SHIP_PRODUCTION : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_PRODUCTION_QUEUE_FRONTLOAD_FACTOR : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_PRODUCTION_QUEUE_TOPPING_UP_FACTOR : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_SHIP_SPEED_FACTOR : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_CONCEDE_COLONIES_THRESHOLD : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_SHIP_STRUCTURE_FACTOR : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_CHEAP_AND_FAST_BUILDING_PRODUCTION : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_CHEAP_AND_FAST_TECH_RESEARCH : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_NUM_COMBAT_ROUNDS : 3 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_BUILDING_COST_FACTOR : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_TECH_COST_FACTOR : 2 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_SHIP_HULL_COST_FACTOR : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_THRESHOLD_HUMAN_PLAYER_WIN : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_TEST_STRING : PLAYER 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_SHIP_PART_COST_FACTOR : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_ENABLE_SUPER_TESTER : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_ONLY_ALLIANCE_WIN : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_SHIP_PART_BASED_UPKEEP : 0 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_HABITABLE_SIZE_TINY : 1 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_HABITABLE_SIZE_SMALL : 2 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_HABITABLE_SIZE_MEDIUM : 3 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_HABITABLE_SIZE_LARGE : 4 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_HABITABLE_SIZE_HUGE : 5 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_HABITABLE_SIZE_ASTEROIDS : 3 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_HABITABLE_SIZE_GASGIANT : 6 20:33:44.222161 [debug] client : gamerules.cpp:190 : ... RULE_ALLOW_CONCEDE : 0 20:33:44.224145 [debug] timer : scopedtimer.cpp:34 : parse_file "CON_ADV_ENGINE.focs.txt" time: 2883 µs 20:33:44.227121 [debug] timer : scopedtimer.cpp:34 : parse_file "CON_GEOINT.focs.txt" time: 2814 µs 20:33:44.230097 [debug] timer : scopedtimer.cpp:34 : parse_file "CON_NANOROBO.focs.txt" time: 2758 µs 20:33:44.233073 [debug] timer : scopedtimer.cpp:34 : parse_file "ENERGY_COMP.focs.txt" time: 2947 µs 20:33:44.236049 [debug] timer : scopedtimer.cpp:34 : parse_file "ENERGY_SOLAR.focs.txt" time: 3070 µs 20:33:44.239521 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_FIFTYSEVEN.focs.txt" time: 32 ms 20:33:44.242497 [debug] timer : scopedtimer.cpp:34 : parse_file "ORBITAL_DRYDOCK.focs.txt" time: 6389 µs 20:33:44.245473 [debug] timer : scopedtimer.cpp:34 : parse_file "ORGANIC_CEL_GRO.focs.txt" time: 2877 µs 20:33:44.247953 [debug] timer : scopedtimer.cpp:34 : parse_file "ORGANIC_ORB_INC.focs.txt" time: 2633 µs 20:33:44.250929 [debug] timer : scopedtimer.cpp:34 : parse_file "ORGANIC_XENO_FAC.focs.txt" time: 2782 µs 20:33:44.254897 [debug] timer : scopedtimer.cpp:34 : parse_file "SOL_ORB_GEN.focs.txt" time: 4088 µs 20:33:44.258369 [debug] timer : scopedtimer.cpp:34 : parse_file "SPACE_ELEVATOR.focs.txt" time: 3439 µs 20:33:44.260849 [debug] timer : scopedtimer.cpp:34 : parse_file "SPATIAL_DISTORT_GEN.focs.txt" time: 2480 µs 20:33:44.263329 [debug] timer : scopedtimer.cpp:34 : parse_file "STARGATE.focs.txt" time: 2456 µs 20:33:44.265809 [debug] timer : scopedtimer.cpp:34 : parse_file "STARLANE_BORE.focs.txt" time: 2230 µs 20:33:44.267793 [debug] timer : scopedtimer.cpp:34 : parse_file "STARLANE_NEXUS.focs.txt" time: 2082 µs 20:33:44.271265 [debug] timer : scopedtimer.cpp:34 : parse_file "STOCKPILING_CENTER.focs.txt" time: 3402 µs 20:33:44.273249 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_FULVER.focs.txt" time: 33 ms 20:33:44.273249 [debug] timer : scopedtimer.cpp:34 : parse_file "SUPER_TEST.focs.txt" time: 2210 µs 20:33:44.276225 [debug] timer : scopedtimer.cpp:34 : parse_file "TERRAFORM.focs.txt" time: 2895 µs 20:33:44.278705 [debug] timer : scopedtimer.cpp:34 : parse_file "TERRAFORM_REVERT.focs.txt" time: 2616 µs 20:33:44.281185 [debug] timer : scopedtimer.cpp:34 : parse_file "TRANSFORMER.focs.txt" time: 2410 µs 20:33:44.282673 [debug] client : savegamepreviewutils.cpp:209 : SaveFileWithValidHeader: Loading headers from: C:/Users/X/AppData/Roaming/FreeOrion/save\auto\FreeOrion_Menschlicher_Spieler_Erdimperium_0027_20181217_202602.sav 20:33:44.282673 [debug] client : savegamepreviewutils.cpp:229 : Deserializing XML data 20:33:44.283665 [debug] client : savegamepreviewutils.cpp:209 : SaveFileWithValidHeader: Loading headers from: C:/Users/X/AppData/Roaming/FreeOrion/save\auto\FreeOrion_Menschlicher_Spieler_Erdimperium_0027_20181217_202602.sav 20:33:44.283665 [debug] client : savegamepreviewutils.cpp:229 : Deserializing XML data 20:33:44.284657 [debug] timer : scopedtimer.cpp:34 : parse_file "XENORESURRECTION_LAB.focs.txt" time: 3477 µs 20:33:44.305985 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_FURTHEST.focs.txt" time: 32 ms 20:33:44.341697 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_GEORGE.focs.txt" time: 35 ms 20:33:44.373936 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_GISGUSGTHRIM.focs.txt" time: 32 ms 20:33:44.407167 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_GYSACHE.focs.txt" time: 33 ms 20:33:44.439904 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_HAPPY.focs.txt" time: 32 ms 20:33:44.472640 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_HHOH.focs.txt" time: 32 ms 20:33:44.504880 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_HUMAN.focs.txt" time: 32 ms 20:33:44.537123 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_KILANDOW.focs.txt" time: 32 ms 20:33:44.568368 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_KOBUNTURA.focs.txt" time: 31 ms 20:33:44.600607 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_LAENFA.focs.txt" time: 32 ms 20:33:44.626895 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_LEMBALALAM.focs.txt" time: 26 ms 20:33:44.660127 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_MISIORLA.focs.txt" time: 33 ms 20:33:44.693359 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_MUURSH.focs.txt" time: 32 ms 20:33:44.725104 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_NYMNMN.focs.txt" time: 31 ms 20:33:44.756848 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_OURBOOLS.focs.txt" time: 31 ms 20:33:44.788592 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_PHINNERT.focs.txt" time: 31 ms 20:33:44.820832 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_RAAAGH.focs.txt" time: 32 ms 20:33:44.853071 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_REPLICON.focs.txt" time: 32 ms 20:33:44.885311 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SCYLIOR.focs.txt" time: 31 ms 20:33:44.917055 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SETINON.focs.txt" time: 31 ms 20:33:44.949791 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SILEXIAN.focs.txt" time: 32 ms 20:33:44.983519 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SLY.focs.txt" time: 33 ms 20:33:45.015759 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SSLITH.focs.txt" time: 32 ms 20:33:45.048991 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_SUPERTEST.focs.txt" time: 33 ms 20:33:45.082223 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_TAEGHIRUS.focs.txt" time: 33 ms 20:33:45.113471 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_TRENCHERS.focs.txt" time: 31 ms 20:33:45.147199 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_TRITH.focs.txt" time: 33 ms 20:33:45.178943 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_UGMORS.focs.txt" time: 31 ms 20:33:45.210687 [debug] timer : scopedtimer.cpp:34 : parse_file "SP_VOLP.focs.txt" time: 31 ms 20:33:50.615214 [debug] client : humanclientapp.cpp:721 : HumanClientApp::LoadSinglePlayerGame 20:33:50.619182 [debug] client : savefiledialog.cpp:584 : SaveFileDialog::FilterColumns: Visible columns: 5 20:33:50.619678 [debug] client : savefiledialog.cpp:536 : SaveFileDialog::FindLocalRelativeDirs name: auto valid UTF-8: true 20:33:50.619678 [debug] client : savegamepreviewutils.cpp:66 : LoadSaveGamePreviewData: Loading preview from: C:/Users/X/AppData/Roaming/FreeOrion/save\save-20181216_150501.sav 20:33:50.619678 [debug] client : savegamepreviewutils.cpp:85 : Deserializing XML data 20:33:50.620174 [debug] client : savegamepreviewutils.cpp:95 : Loaded preview with: 1 human players 20:33:50.620174 [debug] client : savegamepreviewutils.cpp:103 : LoadSaveGamePreviewData: Successfully loaded preview from: C:/Users/X/AppData/Roaming/FreeOrion/save\save-20181216_150501.sav 20:33:52.207056 [debug] client : savefiledialog.cpp:886 : SaveFileDialog::Cancel: Dialog Canceled 20:33:52.223291 [debug] client : humanclientapp.cpp:746 : HumanClientApp::LoadSinglePlayerGame has empty filename. Aborting load. 20:33:52.241502 [debug] client : savegamepreviewutils.cpp:209 : SaveFileWithValidHeader: Loading headers from: C:/Users/X/AppData/Roaming/FreeOrion/save\auto\FreeOrion_Menschlicher_Spieler_Erdimperium_0027_20181217_202602.sav 20:33:52.241502 [debug] client : savegamepreviewutils.cpp:229 : Deserializing XML data 20:33:52.242990 [debug] client : savegamepreviewutils.cpp:209 : SaveFileWithValidHeader: Loading headers from: C:/Users/X/AppData/Roaming/FreeOrion/save\auto\FreeOrion_Menschlicher_Spieler_Erdimperium_0027_20181217_202602.sav 20:33:52.242990 [debug] client : savegamepreviewutils.cpp:229 : Deserializing XML data 20:33:52.723131 [info] log : logger.cpp:198 : Added logger named "network" 20:33:52.723131 [info] log : logger.cpp:330 : Setting "network" logger threshold to "debug". 20:33:52.723131 [debug] log : loggerwithoptionsdb.cpp:105 : Configure log source "network" from optionsDB using threshold debug 20:33:52.723131 [debug] network : clientnetworking.cpp:335 : Attempt to connect to server at one of these addresses: 20:33:52.723131 [debug] network : clientnetworking.cpp:337 : tcp::resolver::iterator host_name: 127.0.0.1 address: 127.0.0.1 port: 12346 20:33:53.724066 [debug] network : clientnetworking.cpp:399 : ConnectToServer() : failed to connect to server. 20:33:53.724066 [debug] client : humanclientapp.cpp:449 : HumanClientApp::StartServer: C:/Users/X/Documents/FreeOrion SDK/FreeOrion/freeoriond.exe 20:33:53.724066 [debug] client : humanclientapp.cpp:483 : ai-config not set. 20:33:58.168882 [debug] network : clientnetworking.cpp:335 : Attempt to connect to server at one of these addresses: 20:33:58.168882 [debug] network : clientnetworking.cpp:337 : tcp::resolver::iterator host_name: 127.0.0.1 address: 127.0.0.1 port: 12346 20:33:58.169384 [debug] network : clientnetworking.cpp:356 : Connected to server at host_name: 127.0.0.1 address: 127.0.0.1 port: 12346 20:33:58.169384 [debug] network : clientnetworking.cpp:380 : Connecting to server took 0 ms. 20:33:58.169384 [debug] network : clientnetworking.cpp:383 : ConnectToServer() : starting networking thread 20:33:58.183693 [debug] client : humanclientapp.cpp:1036 : New roles: 10101 20:33:58.201053 [debug] network : clientnetworking.cpp:442 : ClientNetworking::SetPlayerID: player id set to: 1 20:33:58.201549 [debug] client : sitreppanel.cpp:771 : SitRepPanel::Update() 20:34:00.430891 [debug] network : clientnetworking.cpp:487 : Client connection disconnected by EOF from server. 20:34:00.431351 [debug] client : humanclientapp.cpp:1417 : HumanClientApp::ResetToIntro 20:34:00.431351 [debug] FSM : humanclientfsm.cpp:1198 : QuittingGame terminated server process. 20:34:00.431848 [debug] network : clientnetworking.cpp:442 : ClientNetworking::SetPlayerID: player id set to: -1 20:34:00.432374 [debug] client : sitreppanel.cpp:771 : SitRepPanel::Update() 20:34:00.432840 [debug] client : universe.cpp:161 : Reset id allocators with highest object id = -1 and highest design id = -1 20:34:00.453206 [debug] client : humanclientapp.cpp:1505 : HumanClientApp::DisconnectedFromServer 20:34:00.453696 [debug] client : savegamepreviewutils.cpp:209 : SaveFileWithValidHeader: Loading headers from: C:/Users/X/AppData/Roaming/FreeOrion/save\auto\FreeOrion_Menschlicher_Spieler_Erdimperium_0027_20181217_202602.sav 20:34:00.453696 [debug] client : savegamepreviewutils.cpp:229 : Deserializing XML data 20:34:00.454688 [debug] client : savegamepreviewutils.cpp:209 : SaveFileWithValidHeader: Loading headers from: C:/Users/X/AppData/Roaming/FreeOrion/save\auto\FreeOrion_Menschlicher_Spieler_Erdimperium_0027_20181217_202602.sav 20:34:00.454688 [debug] client : savegamepreviewutils.cpp:229 : Deserializing XML data 20:34:02.710296 [debug] client : humanclientapp.cpp:1417 : HumanClientApp::ExitApp 20:34:02.710296 [debug] client : humanclientapp.cpp:379 : HumanClientApp exited cleanly. 20:34:02.731088 [debug] client : universe.cpp:161 : Reset id allocators with highest object id = -1 and highest design id = -1 20:34:02.731088 [debug] client : chmain.cpp:325 : Human client main exited cleanly.