#4
Post
by Yithazr » Fri Jun 17, 2022 2:49 pm
12:27:31.340541 {0x00007f6c7d7f6780} [info] log : Logger.cpp:200 : Added logger named "log"
12:27:31.340838 {0x00007f6c7d7f6780} [info] log : Logger.cpp:200 : Added logger named "IDallocator"
12:27:31.340874 {0x00007f6c7d7f6780} [info] log : Logger.cpp:380 : Logger initialized at Fri Jun 17 12:27:31 2022
12:27:31.341006 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "log" logger threshold to "debug".
12:27:31.341045 {0x00007f6c7d7f6780} [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "log" from optionsDB using threshold debug
12:27:31.341132 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "server" logger threshold to "debug".
12:27:31.341214 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "IDallocator" logger threshold to "debug".
12:27:31.341244 {0x00007f6c7d7f6780} [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "IDallocator" from optionsDB using threshold debug
12:27:31.341280 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "log" logger threshold to "debug".
12:27:31.341306 {0x00007f6c7d7f6780} [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "log" from optionsDB using threshold debug
12:27:31.341333 {0x00007f6c7d7f6780} [info] log : LoggerWithOptionsDB.cpp:91 : Initialized OptionsDB logging configuration.
12:27:31.341377 {0x00007f6c7d7f6780} [info] server : ServerApp.cpp:104 : v0.4.10.1 [build 2020-09-25.39cfe10] CMake
12:27:31.341436 {0x00007f6c7d7f6780} [info] server : DependencyVersions.cpp:81 : Dependency versions from headers:
12:27:31.341481 {0x00007f6c7d7f6780} [info] server : DependencyVersions.cpp:84 : Boost: 1_74
12:27:31.341511 {0x00007f6c7d7f6780} [info] server : DependencyVersions.cpp:84 : Python: 3.9.1
12:27:31.341537 {0x00007f6c7d7f6780} [info] server : DependencyVersions.cpp:84 : zlib: 1.2.11
12:27:31.343007 {0x00007f6c7d7f6780} [debug] server : GameRules.cpp:22 : Adding options rules
12:27:31.343287 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_NUM_COMBAT_ROUNDS with default value 3
12:27:31.343406 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_AGGRESSIVE_SHIPS_COMBAT_VISIBLE with default value false
12:27:31.343537 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_DIPLOMACY with default value RULE_DIPLOMACY_ALLOWED_FOR_ALL
12:27:31.343616 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_STOCKPILE_IMPORT_LIMITED with default value false
12:27:31.343690 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_PRODUCTION_QUEUE_FRONTLOAD_FACTOR with default value 0
12:27:31.343806 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_PRODUCTION_QUEUE_TOPPING_UP_FACTOR with default value 0
12:27:31.343864 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_CHEAP_AND_FAST_BUILDING_PRODUCTION with default value false
12:27:31.343947 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_CHEAP_AND_FAST_SHIP_PRODUCTION with default value false
12:27:31.344006 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_SHIP_SPEED_FACTOR with default value 1
12:27:31.344070 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_SHIP_STRUCTURE_FACTOR with default value 1
12:27:31.344132 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_SHIP_WEAPON_DAMAGE_FACTOR with default value 1
12:27:31.344194 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_FIGHTER_DAMAGE_FACTOR with default value 1
12:27:31.344269 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_CHEAP_AND_FAST_TECH_RESEARCH with default value false
12:27:31.344331 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_RESEED_PRNG_SERVER with default value true
12:27:31.344388 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_STARLANES_EVERYWHERE with default value false
12:27:31.344469 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_THRESHOLD_HUMAN_PLAYER_WIN with default value 0
12:27:31.344525 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_ONLY_ALLIANCE_WIN with default value true
12:27:31.344573 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_ALLOW_CONCEDE with default value false
12:27:31.344630 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_CONCEDE_COLONIES_THRESHOLD with default value 1
12:27:31.344687 {0x00007f6c7d7f6780} [debug] server : GameRules.h:125 : Added game rule named RULE_SHOW_DETAILED_EMPIRES_DATA with default value true
12:27:31.357821 {0x00007f6c7d7f6780} [info] log : Logger.cpp:200 : Added logger named "FSM"
12:27:31.357956 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "FSM" logger threshold to "debug".
12:27:31.357987 {0x00007f6c7d7f6780} [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "FSM" from optionsDB using threshold debug
12:27:31.358042 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:330 : FreeOrion server waiting for network events
12:27:31.358150 {0x00007f6c7d7f6780} [info] log : Logger.cpp:200 : Added logger named "network"
12:27:31.358211 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "network" logger threshold to "debug".
12:27:31.358238 {0x00007f6c7d7f6780} [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "network" from optionsDB using threshold debug
12:27:31.358713 {0x00007f6c7d7f6780} [info] server : i18n.cpp:177 : Global locale: en_GB.UTF-8
12:27:31.361773 {0x00007f6c7d7f6780} [debug] server : i18n.cpp:43 : Detected locale language: en
12:27:31.361863 {0x00007f6c7d7f6780} [debug] server : i18n.cpp:58 : GetDefaultStringTableFileName returning: /usr/share/games/freeorion/default/stringtables/en.txt
12:27:31.361897 {0x00007f6c7d7f6780} [debug] server : i18n.cpp:82 : Stringtable option path:
12:27:31.361924 {0x00007f6c7d7f6780} [debug] server : i18n.cpp:85 : Stringtable option path not specified yet, using default: /usr/share/games/freeorion/default/stringtables/en.txt
12:27:31.899171 {0x00007f6c727fc700} [info] log : Logger.cpp:200 : Added logger named "timer"
12:27:31.899319 {0x00007f6c727fc700} [info] log : Logger.cpp:338 : Setting "timer" logger threshold to "debug".
12:27:31.899349 {0x00007f6c727fc700} [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "timer" from optionsDB using threshold debug
12:27:31.899382 {0x00007f6c727fc700} [debug] timer : ScopedTimer.cpp:35 : parse_file "fleets.inf" time: 534 ms
12:27:32.054246 {0x00007f6c717fa700} [warn] server : Parse.cpp:526 : A parser failed while parsing "/usr/share/games/freeorion/default/scripting/empire_statistics/STATISTICS_TEST.focs.txt"
12:27:32.055671 {0x00007f6c717fa700} [debug] timer : ScopedTimer.cpp:35 : parse_file "STATISTICS_TEST.focs.txt" time: 682 ms
12:27:32.074890 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "Categories.inf" time: 717 ms
12:27:32.081239 {0x00007f6c717fa700} [debug] timer : ScopedTimer.cpp:35 : parse_file "COLONIES_COUNT.focs.txt" time: 19.6 ms
12:27:32.093525 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "COL_BANFORO.focs.txt" time: 12.4 ms
12:27:32.100088 {0x00007f6c717fa700} [debug] timer : ScopedTimer.cpp:35 : parse_file "RP_OUTPUT.focs.txt" time: 18.6 ms
12:27:32.113663 {0x00007f6c717fa700} [debug] timer : ScopedTimer.cpp:35 : parse_file "Empire.focs.txt" time: 13.4 ms
12:27:32.115183 {0x00007f6c7c7f0700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FLD_NEBULA_2.focs.txt" time: 752 ms
12:27:32.117166 {0x00007f6c7cff1700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SPY_CATEGORY.focs.txt" time: 760 ms
12:27:32.119053 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "COL_MISIORLA.focs.txt" time: 25.3 ms
12:27:32.120220 {0x00007f6c78fe9700} [debug] server : 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
12:27:32.120436 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_SHIP_HULL_COST_FACTOR with default value 1
12:27:32.120531 {0x00007f6c78fe9700} [debug] server : 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
12:27:32.120600 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_SHIP_PART_COST_FACTOR with default value 1
12:27:32.120832 {0x00007f6c78fe9700} [debug] server : 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
12:27:32.120920 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_TECH_COST_FACTOR with default value 2
12:27:32.120997 {0x00007f6c78fe9700} [debug] server : 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
12:27:32.121061 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_BUILDING_COST_FACTOR with default value 1
12:27:32.121121 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:28 : Adding Boolean game rule with name: RULE_ENABLE_EXPERIMENTORS, desc: RULE_ENABLE_EXPERIMENTORS_DESC, default: true
12:27:32.128380 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_ENABLE_EXPERIMENTORS with default value true
12:27:32.128492 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:28 : Adding Boolean game rule with name: RULE_ENABLE_SUPER_TESTER, desc: RULE_ENABLE_SUPER_TESTER_DESC, default: false
12:27:32.128545 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_ENABLE_SUPER_TESTER with default value false
12:27:32.128822 {0x00007f6c78fe9700} [debug] server : 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",
12:27:32.128925 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_TEST_STRING with default value PLAYER
12:27:32.129004 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_TINY, desc: RULE_HABITABLE_SIZE_DESC, default: 1, min: 0, max: 999
12:27:32.129071 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_HABITABLE_SIZE_TINY with default value 1
12:27:32.129134 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_SMALL, desc: RULE_HABITABLE_SIZE_DESC, default: 2, min: 0, max: 999
12:27:32.129188 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_HABITABLE_SIZE_SMALL with default value 2
12:27:32.129251 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_MEDIUM, desc: RULE_HABITABLE_SIZE_DESC, default: 3, min: 0, max: 999
12:27:32.130921 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_HABITABLE_SIZE_MEDIUM with default value 3
12:27:32.131071 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_LARGE, desc: RULE_HABITABLE_SIZE_DESC, default: 4, min: 0, max: 999
12:27:32.131131 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_HABITABLE_SIZE_LARGE with default value 4
12:27:32.131198 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_HUGE, desc: RULE_HABITABLE_SIZE_DESC, default: 5, min: 0, max: 999
12:27:32.131251 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_HABITABLE_SIZE_HUGE with default value 5
12:27:32.133590 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_ASTEROIDS, desc: RULE_HABITABLE_SIZE_DESC, default: 3, min: 0, max: 999
12:27:32.133729 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_HABITABLE_SIZE_ASTEROIDS with default value 3
12:27:32.133802 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:37 : Adding Integer game rule with name: RULE_HABITABLE_SIZE_GASGIANT, desc: RULE_HABITABLE_SIZE_DESC, default: 6, min: 0, max: 999
12:27:32.133859 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_HABITABLE_SIZE_GASGIANT with default value 6
12:27:32.133913 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:28 : Adding Boolean game rule with name: RULE_SHIP_PART_BASED_UPKEEP, desc: RULE_SHIP_PART_BASED_UPKEEP_DESC, default: false
12:27:32.133968 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_SHIP_PART_BASED_UPKEEP with default value false
12:27:32.134021 {0x00007f6c78fe9700} [debug] server : GameRulesParser.cpp:28 : Adding Boolean game rule with name: RULE_ENABLE_ALLIED_REPAIR, desc: RULE_ENABLE_ALLIED_REPAIR_DESC, default: false
12:27:32.134071 {0x00007f6c78fe9700} [debug] server : GameRules.h:125 : Added game rule named RULE_ENABLE_ALLIED_REPAIR with default value false
12:27:32.135043 {0x00007f6c78fe9700} [debug] timer : ScopedTimer.cpp:35 : parse_file "game_rules.focs.txt" time: 770 ms
12:27:32.136857 {0x00007f6c717fa700} [debug] timer : ScopedTimer.cpp:35 : parse_file "PP_OUTPUT.focs.txt" time: 21.7 ms
12:27:32.140986 {0x00007f6c72ffd700} [debug] timer : ScopedTimer.cpp:35 : parse_file "buildings.inf" time: 775 ms
12:27:32.142096 {0x00007f6c7cff1700} [debug] timer : ScopedTimer.cpp:35 : parse_file "EXTINCT_SPECIES_TECHS.focs.txt" time: 22.4 ms
12:27:32.164675 {0x00007f6c7cff1700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DESIGN_WINDOW.focs.txt" time: 13.1 ms
12:27:32.167517 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_FIGHTERS_2.focs.txt" time: 42.9 ms
12:27:32.187587 {0x00007f6c7c7f0700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FLD_NEBULA_1.focs.txt" time: 72.2 ms
12:27:32.210401 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_FIGHTERS_3.focs.txt" time: 42.7 ms
12:27:32.213993 {0x00007f6c7cff1700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ORBITAL_DRYDOCK_REPAIR.focs.txt" time: 18 ms
12:27:32.227526 {0x00007f6c7c7f0700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FLD_SUBSPACE_RIFT.focs.txt" time: 39.7 ms
12:27:32.229864 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_FIGHTERS_4.focs.txt" time: 19.2 ms
12:27:32.242397 {0x00007f6c79feb700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SD_AST_1.focs.txt" time: 892 ms
12:27:32.247923 {0x00007f6c7cff1700} [debug] timer : ScopedTimer.cpp:35 : parse_file "PC_BOMBARD.focs.txt" time: 12.1 ms
12:27:32.256641 {0x00007f6c797ea700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SM_DRAGON.focs.txt" time: 909 ms
12:27:32.258976 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_FIGHTERS_1.focs.txt" time: 28.9 ms
12:27:32.260330 {0x00007f6c79feb700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SD_GRAVITATING2.focs.txt" time: 16.6 ms
12:27:32.280523 {0x00007f6c7c7f0700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FLD_ION_STORM.focs.txt" time: 52.8 ms
12:27:32.288022 {0x00007f6c79feb700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SD_OUTPOST_BASE.focs.txt" time: 24.3 ms
12:27:32.293459 {0x00007f6c7c7f0700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FLD_ACCRETION_DISC.focs.txt" time: 12.7 ms
12:27:32.296085 {0x00007f6c797ea700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SM_CLOUD.focs.txt" time: 36.3 ms
12:27:32.300962 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_VOID_SHADOW.focs.txt" time: 33.4 ms
12:27:32.310638 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_BASIC_LARGE.focs.txt" time: 879 ms
12:27:32.312146 {0x00007f6c79feb700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SD_ROBOTIC_OUTPOST_HULL.focs.txt" time: 20.3 ms
12:27:32.324740 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_BIOTERM.focs.txt" time: 23.6 ms
12:27:32.340181 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_EMP.focs.txt" time: 15.2 ms
12:27:32.342879 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CONC_CAMP_MASTER.focs.txt" time: 801 ms
12:27:32.344178 {0x00007f6c7c7f0700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FLD_MOLECULAR_CLOUD.focs.txt" time: 50.5 ms
12:27:32.354548 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_DARK_RAY.focs.txt" time: 11 ms
12:27:32.357920 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FU_RAMSCOOP.focs.txt" time: 1003 ms
12:27:32.363977 {0x00007f6c71ffb700} [debug] timer : ScopedTimer.cpp:35 : parse_file "monster_fleets.inf" time: 809 ms
12:27:32.368435 {0x00007f6c737fe700} [debug] timer : ScopedTimer.cpp:35 : parse_file "items.inf" time: 911 ms
12:27:32.374839 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_GRV.focs.txt" time: 20.1 ms
12:27:32.381068 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CONC_CAMP_SLAVE.focs.txt" time: 38 ms
12:27:32.393527 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SUPERNOVA.focs.txt" time: 12.3 ms
12:27:32.397123 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FU_BASIC_TANK.focs.txt" time: 39 ms
12:27:32.399296 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_CHAOS_WAVE.focs.txt" time: 17.9 ms
12:27:32.408425 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_ENERGY_FRIGATE.focs.txt" time: 97.6 ms
12:27:32.412578 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "NOVA_BOMB_ACTIVATOR.focs.txt" time: 18.9 ms
12:27:32.419187 {0x00007f6c7d7f6780} [debug] server : SaveLoad.cpp:533 : Reading player save game data from: /home/un/.local/share/freeorion/save/save-20220617_114505.sav
12:27:32.419391 {0x00007f6c7d7f6780} [debug] server : SaveLoad.cpp:555 : Attempting XML deserialization...
12:27:32.424353 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FU_ZERO_FUEL.focs.txt" time: 27 ms
12:27:32.435902 {0x00007f6c7d7f6780} [debug] server : SaveLoad.cpp:565 : Done reading player save game data...
12:27:32.436043 {0x00007f6c7d7f6780} [debug] timer : ScopedTimer.cpp:35 : LoadPlayerSaveHeaderData: /home/un/.local/share/freeorion/save/save-20220617_114505.sav time: 16.8 ms
12:27:32.436152 {0x00007f6c7d7f6780} [debug] server : SaveLoad.cpp:533 : Reading player save game data from: /home/un/.local/share/freeorion/save/save-20220617_114505.sav
12:27:32.436255 {0x00007f6c7d7f6780} [debug] server : SaveLoad.cpp:555 : Attempting XML deserialization...
12:27:32.436586 {0x00007f6c7d7f6780} [debug] server : SaveLoad.cpp:565 : Done reading player save game data...
12:27:32.436665 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:199 : ServerApp::CreateAIClients: 10 player (maybe not all AIs) at max aggression: 5
12:27:32.436766 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:356 : ServerApp::CleanupAIs() telling AIs game is ending
12:27:32.436798 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:376 : ServerApp::CleanupAIs() killing 0 AI clients.
12:27:32.436852 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:259 : starting AIs with /usr/lib/freeorion/freeorionca
12:27:32.436879 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:260 : ai-aggression set to 5
12:27:32.436907 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:261 : ai-path set to 'python/AI'
12:27:32.436936 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:268 : ai-config not set.
12:27:32.442974 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DERELICT_3.focs.txt" time: 21.5 ms
12:27:32.445831 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_2_2.focs.txt" time: 43.1 ms
12:27:32.455742 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FU_TRANSPATIAL_DRIVE.focs.txt" time: 31.1 ms
12:27:32.455921 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_6
12:27:32.476265 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_SOLAR.focs.txt" time: 67.6 ms
12:27:32.479128 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_9
12:27:32.483822 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ACCRETION_DISC.focs.txt" time: 22.7 ms
12:27:32.489616 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_4_2.focs.txt" time: 43.5 ms
12:27:32.500230 {0x00007f6c7b7ee700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SP_GEORGE.focs.txt" time: 1146 ms
12:27:32.511858 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_1
12:27:32.514803 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "PANOPTICON.focs.txt" time: 30.6 ms
12:27:32.531468 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FU_IMPROVED_ENGINE_COUPLINGS.focs.txt" time: 65.3 ms
12:27:32.538790 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_4
12:27:32.567962 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_5
12:27:32.581394 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_1_2.focs.txt" time: 91.5 ms
12:27:32.590253 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "GAIA.focs.txt" time: 75.2 ms
12:27:32.571692 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_2
12:27:32.600929 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_QUANTUM_ENERGY.focs.txt" time: 124 ms
12:27:32.610070 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FU_SINGULARITY_ENGINE_CORE.focs.txt" time: 78.4 ms
12:27:32.614125 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "COMPUTRONIUM.focs.txt" time: 23.7 ms
12:27:32.630476 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_3_1.focs.txt" time: 48.9 ms
12:27:32.660923 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "EXTINCT_MISIORLA.focs.txt" time: 46.5 ms
12:27:32.663867 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_7
12:27:32.684065 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_9
12:27:32.714076 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "HIGH_TECH_NATIVES.focs.txt" time: 52.7 ms
12:27:32.720262 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_1_3.focs.txt" time: 89.6 ms
12:27:32.723089 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FU_N_DIMENSIONAL_ENGINE_MATRIX.focs.txt" time: 112 ms
12:27:32.727887 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:286 : done starting AI AI_3
12:27:32.728371 {0x00007f6c7d7f6780} [debug] server : CommonFramework.cpp:39 : Initializing FreeOrion Python interface
12:27:32.728574 {0x00007f6c7d7f6780} [debug] server : ServerFramework.cpp:60 : Initializing server Python imports
12:27:32.739639 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CONC_CAMP.focs.txt" time: 1161 ms
12:27:32.750871 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ART_PLANET.focs.txt" time: 11 ms
12:27:32.755409 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_SOLAR_CONNECTION.focs.txt" time: 34.9 ms
12:27:32.758202 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "EXTINCT_BANFORO.focs.txt" time: 43.8 ms
12:27:32.779564 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "TRANSFORMER.focs.txt" time: 28.5 ms
12:27:32.781900 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SCRYING_SPHERE.focs.txt" time: 23.5 ms
12:27:32.784123 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_STD_PLATE.focs.txt" time: 60.8 ms
12:27:32.786710 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_4_1.focs.txt" time: 22.6 ms
12:27:32.793384 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CULTURE_LIBRARY.focs.txt" time: 13.5 ms
12:27:32.794508 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_FRACTAL_ENERGY.focs.txt" time: 193 ms
12:27:32.804959 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_3_4.focs.txt" time: 18 ms
12:27:32.809858 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "NEUTRONIUM_EXTRACTOR.focs.txt" time: 16.3 ms
12:27:32.823565 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_3_2.focs.txt" time: 18.4 ms
12:27:32.825165 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "HONEYCOMB.focs.txt" time: 43.1 ms
12:27:32.828047 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_NEUTRONIUM_PLATE.focs.txt" time: 43.7 ms
12:27:32.843719 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_2_3.focs.txt" time: 20 ms
12:27:32.845578 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ORGANIC_XENO_FAC.focs.txt" time: 26.5 ms
12:27:32.848071 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "KRAKEN_IN_THE_ICE.focs.txt" time: 22.7 ms
12:27:32.854932 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_ZORTRIUM_PLATE.focs.txt" time: 26.7 ms
12:27:32.859891 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ORGANIC_CEL_GRO.focs.txt" time: 14.1 ms
12:27:32.865619 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_COMPRESSED_ENERGY.focs.txt" time: 70.9 ms
12:27:32.878063 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_XENTRONIUM_PLATE.focs.txt" time: 22.9 ms
12:27:32.879365 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_ARC_DISRUPTOR.focs.txt" time: 35.4 ms
12:27:32.885466 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "BASE.focs.txt" time: 25.4 ms
12:27:32.897320 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ANCIENT_RUINS.focs.txt" time: 49.1 ms
12:27:32.899395 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_4_4.focs.txt" time: 19.8 ms
12:27:32.902551 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ASTEROID.focs.txt" time: 16.9 ms
12:27:32.907438 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_PRECURSOR_PLATE.focs.txt" time: 29.2 ms
12:27:32.913588 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "RESONANT_MOON.focs.txt" time: 16.1 ms
12:27:32.917668 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_2_1.focs.txt" time: 18.1 ms
12:27:32.930222 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "MODERATE_TECH_NATIVES.focs.txt" time: 16.4 ms
12:27:32.942240 {0x00007f6c7d7f6780} [debug] server : CommonFramework.cpp:66 : Python initialized
12:27:32.942346 {0x00007f6c7d7f6780} [debug] server : CommonFramework.cpp:67 : Python version: 3.9.2 (default, Feb 28 2021, 17:03:44)
[GCC 10.2.1 20210110]
12:27:32.942380 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_BASIC_MEDIUM.focs.txt" time: 76.6 ms
12:27:32.942391 {0x00007f6c7d7f6780} [debug] server : CommonFramework.cpp:68 : Python prefix: /usr
12:27:32.942463 {0x00007f6c7d7f6780} [debug] server : CommonFramework.cpp:69 : Python module search path: /usr/lib/python39.zip:/usr/lib/python3.9:/usr/lib/python3.9/lib-dynload
12:27:32.942524 {0x00007f6c7d7f6780} [debug] server : CommonFramework.cpp:76 : Initializing C++ interfaces for Python
12:27:32.944853 {0x00007f6c7d7f6780} [debug] server : ServerFramework.cpp:66 : Initializing server Python modules
12:27:32.957440 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "POSITRONIUM.focs.txt" time: 27 ms
12:27:32.960994 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_ROCK_PLATE.focs.txt" time: 53.3 ms
12:27:32.975330 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_3_3.focs.txt" time: 57.5 ms
12:27:32.975359 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_DIAMOND_PLATE.focs.txt" time: 14.2 ms
12:27:32.987830 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ORBITAL_DRYDOCK.focs.txt" time: 85 ms
12:27:32.996866 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FRUIT.focs.txt" time: 39.2 ms
12:27:33.010912 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "AR_CRYSTAL_PLATE.focs.txt" time: 25 ms
12:27:33.014637 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ENERGY_COMP.focs.txt" time: 26.6 ms
12:27:33.016795 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_2_4.focs.txt" time: 41.2 ms
12:27:33.025137 {0x00007f6c7b7ee700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SP_HUMAN.focs.txt" time: 524 ms
12:27:33.028655 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_MINIASTEROID_SWARM.focs.txt" time: 86.1 ms
12:27:33.032585 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CRYSTALS.focs.txt" time: 35.5 ms
12:27:33.037519 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_SPINAL_ANTIMATTER.focs.txt" time: 11.6 ms
12:27:33.044287 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ENERGY_SOLAR.focs.txt" time: 29.4 ms
12:27:33.056530 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FT_HANGAR_1.focs.txt" time: 45.4 ms
12:27:33.057650 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CON_NANOROBO.focs.txt" time: 13.2 ms
12:27:33.062352 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ELERIUM.focs.txt" time: 29.6 ms
12:27:33.064826 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_WEAPON_1_4.focs.txt" time: 27.1 ms
12:27:33.085716 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "MINERALS.focs.txt" time: 23.2 ms
12:27:33.087739 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ASTEROID_REF.focs.txt" time: 29.9 ms
12:27:33.091139 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FT_HANGAR_3.focs.txt" time: 34.4 ms
12:27:33.099471 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_CRYSTALLIZED_ASTEROID.focs.txt" time: 70.5 ms
12:27:33.109621 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SHP_ROOT_AGGRESSION.focs.txt" time: 41.4 ms
12:27:33.114176 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CON_GEOINT.focs.txt" time: 26.2 ms
12:27:33.119156 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "PROBIOTIC.focs.txt" time: 33.2 ms
12:27:33.128420 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FT_HANGAR_0.focs.txt" time: 37 ms
12:27:33.129804 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "INDUSTRY_CENTER_II.focs.txt" time: 20 ms
12:27:33.140142 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ORGANIC_ORB_INC.focs.txt" time: 25.8 ms
12:27:33.150238 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SUPERCONDUCTOR.focs.txt" time: 30.9 ms
12:27:33.161132 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_ASTEROID.focs.txt" time: 61.5 ms
12:27:33.162588 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CON_ADV_ENGINE.focs.txt" time: 22.2 ms
12:27:33.163595 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "MONOPOLE.focs.txt" time: 13.2 ms
12:27:33.169206 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FT_HANGAR_4.focs.txt" time: 40.6 ms
12:27:33.184162 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "INTERSTELLAR_ENTANGLEMENT_FACTORY.focs.txt" time: 47 ms
12:27:33.190982 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FT_HANGAR_KRILL.focs.txt" time: 21.6 ms
12:27:33.191916 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SCRYING_SPHERE.focs.txt" time: 25.5 ms
12:27:33.202744 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SPICE.focs.txt" time: 39 ms
12:27:33.212761 {0x00007f6c7d7f6780} [info] log : Logger.cpp:200 : Added logger named "python"
12:27:33.212944 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "python" logger threshold to "debug".
12:27:33.212978 {0x00007f6c7d7f6780} [debug] log : LoggerWithOptionsDB.cpp:105 : Configure log source "python" from optionsDB using threshold debug
12:27:33.213014 {0x00007f6c7d7f6780} [debug] python : configure_logging.py:203 : Python stdout and stderr are redirected to ai process.
12:27:33.213676 {0x00007f6c7d7f6780} [info] python : configure_logging.py:223 : The python logger is initialized with a log level of DEBUG
12:27:33.217311 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ANCIENT_RUINS_DEPLETED.focs.txt" time: 14.4 ms
12:27:33.222611 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ADAPTIVE_AUTOMATION.focs.txt" time: 38.2 ms
12:27:33.225984 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "FT_HANGAR_2.focs.txt" time: 34.8 ms
12:27:33.230491 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "GAIA_TRANS.focs.txt" time: 38.4 ms
12:27:33.237568 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "VOLCANIC_ASH_SLAVE.focs.txt" time: 20.1 ms
12:27:33.248314 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CO_COL_OUTPOST.focs.txt" time: 22.1 ms
12:27:33.255002 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DIM_RIFT_MASTER.focs.txt" time: 17.2 ms
12:27:33.257014 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SINGULAR_GEN.focs.txt" time: 29.4 ms
12:27:33.264356 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_SMALL_CAMOUFLAGE_ASTEROID.focs.txt" time: 103 ms
12:27:33.268654 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CO_COLONY_POD.focs.txt" time: 20.1 ms
12:27:33.276662 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SOLAR_ORB_GEN.focs.txt" time: 19.4 ms
12:27:33.280505 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CLOUD_COVER_SLAVE.focs.txt" time: 25.2 ms
12:27:33.282916 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "COLONY_BASE.focs.txt" time: 40.9 ms
12:27:33.285240 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CO_SUPEND_ANIM_POD.focs.txt" time: 16.4 ms
12:27:33.293800 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "VOID_SLAVE.focs.txt" time: 13.1 ms
12:27:33.297994 {0x00007f6c7d7f6780} [warn] python : auth.py:36 : Cann't read auth file /home/un/.config/freeorion/auth.txt: <class 'FileNotFoundError'> [Errno 2] No such file or directory: '/home/un/.config/freeorion/auth.txt'
12:27:33.298222 {0x00007f6c7d7f6780} [info] python : auth.py:41 : Auth initialized
12:27:33.300016 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "BLACK_HOLE_COLLAPSER.focs.txt" time: 16.9 ms
12:27:33.310133 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "VOID_MASTER.focs.txt" time: 16.1 ms
12:27:33.314920 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DT_DETECTOR_1.focs.txt" time: 29.5 ms
12:27:33.322481 {0x00007f6c7d7f6780} [info] python : chat.py:14 : Chat initialized
12:27:33.322635 {0x00007f6c7d7f6780} [debug] server : ServerFramework.cpp:111 : Server Python modules successfully initialized!
12:27:33.322670 {0x00007f6c7d7f6780} [debug] server : CommonFramework.cpp:112 : FreeOrion Python interface successfully initialized!
12:27:33.323076 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_HEAVY_ASTEROID.focs.txt" time: 58.5 ms
12:27:33.332028 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "VOID_PREDICTION.focs.txt" time: 40.5 ms
12:27:33.336887 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DIM_RIFT_SLAVE.focs.txt" time: 26.5 ms
12:27:33.342211 {0x00007f6c7b7ee700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SP_LAENFA.focs.txt" time: 316 ms
12:27:33.344382 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "GATEWAY_VOID.focs.txt" time: 44.2 ms
12:27:33.346686 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DT_DETECTOR_4.focs.txt" time: 31.5 ms
12:27:33.347316 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "CLOUD_COVER_MASTER.focs.txt" time: 10.2 ms
12:27:33.356147 {0x00007f6c7d7f6780} [debug] server : ServerApp.cpp:456 : Handling logging config message from the host.
12:27:33.356497 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "ai" logger threshold to "debug".
12:27:33.356554 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "client" logger threshold to "debug".
12:27:33.356599 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "server" logger threshold to "debug".
12:27:33.356638 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "FSM" logger threshold to "debug".
12:27:33.356677 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "IDallocator" logger threshold to "debug".
12:27:33.356714 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "combat" logger threshold to "debug".
12:27:33.356751 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "combat_log" logger threshold to "debug".
12:27:33.356788 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "conditions" logger threshold to "debug".
12:27:33.356826 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "effects" logger threshold to "debug".
12:27:33.356866 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "log" logger threshold to "debug".
12:27:33.356904 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "network" logger threshold to "debug".
12:27:33.356944 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "python" logger threshold to "debug".
12:27:33.356982 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "supply" logger threshold to "debug".
12:27:33.357021 {0x00007f6c7d7f6780} [info] log : Logger.cpp:338 : Setting "timer" logger threshold to "debug".
12:27:33.366468 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "NEUTRONIUM_FORGE.focs.txt" time: 21.9 ms
12:27:33.367257 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "HEAD_ON_A_SPIKE.focs.txt" time: 16.8 ms
12:27:33.370976 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "GENERIC_SUPPLIES.focs.txt" time: 34.8 ms
12:27:33.371371 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DT_DETECTOR_2.focs.txt" time: 24.5 ms
12:27:33.390841 {0x00007f6c7d7f2700} [debug] timer : ScopedTimer.cpp:35 : parse_file "GENOME_BANK.focs.txt" time: 24.2 ms
12:27:33.396224 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "DT_DETECTOR_3.focs.txt" time: 24.7 ms
12:27:33.399932 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ZERO_GEN.focs.txt" time: 28.7 ms
12:27:33.411407 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "PHILOSOPHER.focs.txt" time: 33.2 ms
12:27:33.412133 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_CAMOUFLAGE_ASTEROID.focs.txt" time: 88.8 ms
12:27:33.437367 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "WORLDTREE.focs.txt" time: 25.7 ms
12:27:33.441495 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SR_PLASMA_DISCHARGE.focs.txt" time: 45.1 ms
12:27:33.449075 {0x00007f6c73fff700} [debug] timer : ScopedTimer.cpp:35 : parse_file "EXOBOTS.focs.txt" time: 20.3 ms
12:27:33.460350 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "TEMPORAL_ANOMOLY.focs.txt" time: 22.8 ms
12:27:33.470454 {0x00007f6c7afed700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SR_SPINAL_ANTIMATTER.focs.txt" time: 28.8 ms
12:27:33.473224 {0x00007f6c7bfef700} [debug] timer : ScopedTimer.cpp:35 : parse_file "ABANDONED_COLONY.focs.txt" time: 12.7 ms
12:27:33.474083 {0x00007f6c7a7ec700} [debug] timer : ScopedTimer.cpp:35 : parse_file "SH_SMALL_ASTEROID.focs.txt" time: 61.7 ms