FAForever / client

FAF Python Client
GNU General Public License v3.0
75 stars 88 forks source link

forever.log growing indefinitely until disk full #187

Closed Crotalus closed 8 years ago

Crotalus commented 9 years ago

Log is filled with this error

2015-03-24 10:34:20,128 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
Crotalus commented 9 years ago

Lines before the error starts to spam:

2015-03-23 23:27:55,832 INFO     faf.secondaryServer.Statistic Instanciating secondary server.
2015-03-23 23:27:55,842 INFO     faf.util             Read common stylesheet: client/client.css
2015-03-23 23:27:55,930 INFO     faf.util             Read common stylesheet: stats/formatters/style.css
2015-03-23 23:27:55,946 INFO     faf.secondaryServer.Tournament Instanciating secondary server.
2015-03-23 23:27:55,946 INFO     faf.util             Read common stylesheet: tournaments/formatters/style.css
2015-03-23 23:27:55,947 DEBUG    faf.vault            Map Vault tab instantiating
2015-03-23 23:27:56,977 DEBUG    faf.modvault         Mod Vault tab instantiating
2015-03-23 23:27:57,000 DEBUG    faf.modvault         getting installed mods. Count: 18
2015-03-23 23:27:57,013 INFO     faf.replays          Replays Widget instantiated.
2015-03-23 23:27:57,015 INFO     faf.tutorials        Tutorials instantiated.
2015-03-23 23:27:57,023 INFO     faf.util             Read common stylesheet: coop/formatters/style.css
2015-03-23 23:27:57,049 INFO     faf.fa.replayserver  listening on address 127.0.0.1:15000
2015-03-23 23:27:57,051 INFO     faf.fa.relayserver   relay listening on address 127.0.0.1:50008
2015-03-23 23:27:57,115 INFO     faf.client           Outgoing JSON Message: {"command": "ask_session"}
2015-03-23 23:27:59,236 INFO     faf.client           Attempting to login as: Crotalus
2015-03-23 23:27:59,237 INFO     faf.client           Outgoing JSON Message: login.
2015-03-23 23:27:59,434 INFO     faf.client           Login accepted.
2015-03-23 23:27:59,436 INFO     faf.fa.upnp          Creating UPnP port mappings...
2015-03-23 23:27:59,713 INFO     faf.fa.upnp          -> UDP mapping of 192.168.10.112:6112 to 213.21.73.38:6112
2015-03-23 23:27:59,721 INFO     faf.client           The game port is now set to 6112
2015-03-23 23:27:59,721 INFO     faf.client           sending packet to lobby.faforever.com
2015-03-23 23:28:01,269 DEBUG    faf.downloader       Searching map preview for: fortress teamplay_ai
2015-03-23 23:31:05,142 DEBUG    faf.downloader       Searching map preview for: desert arena.v0001
2015-03-23 23:34:55,042 DEBUG    faf.downloader       Searching map preview for: 6vs6 battle of thermopylae v5
2015-03-23 23:35:05,046 DEBUG    faf.downloader       Searching map preview for: voodoo planet v2b
2015-03-23 23:35:35,049 DEBUG    faf.downloader       Searching map preview for: scmp_018
2015-03-23 23:36:25,059 DEBUG    faf.downloader       Searching map preview for: temples teamplay_ai
2015-03-23 23:41:25,069 DEBUG    faf.downloader       Searching map preview for: 6v6 team tournament map two
2015-03-23 23:42:55,055 DEBUG    faf.downloader       Searching map preview for: 5vs5 battle of thermopylae v2
2015-03-23 23:55:01,957 DEBUG    faf.downloader       Searching map preview for: flat 512
2015-03-23 23:56:01,881 DEBUG    faf.downloader       Searching map preview for: gap of genesis teamplay_ai
2015-03-23 23:56:41,888 DEBUG    faf.downloader       Searching map preview for: x1mp_008
2015-03-23 23:57:01,907 DEBUG    faf.downloader       Searching map preview for: drakes_ravine_4v4_v3
2015-03-23 23:57:11,901 DEBUG    faf.downloader       Searching map preview for: gap of genesis
2015-03-23 23:58:06,905 DEBUG    faf.downloader       Searching map preview for: tt open palms.v0001
2015-03-24 00:01:36,871 DEBUG    faf.downloader       Searching map preview for: scmp_haz09fa.v0001
2015-03-24 00:03:47,293 DEBUG    faf.downloader       Searching map preview for: bmbattlegroundv11
2015-03-24 00:03:57,276 DEBUG    faf.downloader       Searching map preview for: flat
2015-03-24 00:04:52,305 DEBUG    faf.downloader       Searching map preview for: sulphur mounds.v0002
2015-03-24 00:04:52,309 DEBUG    faf.downloader       Searching map preview for: canis 5v5 spezial edition
2015-03-24 00:05:47,308 DEBUG    faf.downloader       Searching map preview for: gap of rhonda teamplay.v0006
2015-03-24 00:06:57,279 DEBUG    faf.downloader       Searching map preview for: summer duel.v0002
2015-03-24 00:07:22,956 DEBUG    faf.downloader       Searching map preview for: malazgirt.v0003
2015-03-24 00:07:32,937 DEBUG    faf.downloader       Searching map preview for: 5iver survival land naval.v0001
2015-03-24 00:08:37,905 DEBUG    faf.downloader       Searching map preview for: the drunken pirates dance teamplayai
2015-03-24 00:09:42,914 DEBUG    faf.downloader       Searching map preview for: crimson_feud
2015-03-24 00:13:48,424 DEBUG    faf.downloader       Searching map preview for: scmp_033
2015-03-24 00:14:33,420 DEBUG    faf.downloader       Searching map preview for: mountain pass
2015-03-24 00:16:34,289 DEBUG    faf.downloader       Searching map preview for: world2domination.v0001
2015-03-24 00:17:54,348 DEBUG    faf.downloader       Searching map preview for: last oasis.v0002
2015-03-24 00:19:39,319 DEBUG    faf.downloader       Searching map preview for: scmp_di_509.v0001
2015-03-24 00:20:14,286 DEBUG    faf.downloader       Searching map preview for: monkey playland.v0001
2015-03-24 00:21:49,278 DEBUG    faf.downloader       Searching map preview for: chokequest.v0006
2015-03-24 00:23:04,318 DEBUG    faf.downloader       Searching map preview for: water world.v0001
2015-03-24 00:24:39,285 DEBUG    faf.downloader       Searching map preview for: coastal bridge v2
2015-03-24 00:25:09,285 DEBUG    faf.downloader       Searching map preview for: fight of the giants v3.v0001
2015-03-24 00:25:59,285 DEBUG    faf.downloader       Searching map preview for: tkp_isis_6v6
2015-03-24 00:26:54,289 DEBUG    faf.downloader       Searching map preview for: gap_of_rohan_island.v0004
2015-03-24 00:30:44,372 DEBUG    faf.downloader       Searching map preview for: cauldron_desert.v0001
2015-03-24 00:32:04,286 DEBUG    faf.downloader       Searching map preview for: thermopylae v3.v0003
2015-03-24 00:38:54,627 DEBUG    faf.downloader       Searching map preview for: slaughter pass.v0001
2015-03-24 00:41:04,637 DEBUG    faf.downloader       Searching map preview for: hilly_plateau_small.v0001
2015-03-24 00:42:54,630 DEBUG    faf.downloader       Searching map preview for: kazam
2015-03-24 00:43:59,630 DEBUG    faf.downloader       Searching map preview for: diversity.v0008
2015-03-24 00:47:39,642 DEBUG    faf.downloader       Searching map preview for: wonder 5v5
2015-03-24 00:52:29,634 DEBUG    faf.downloader       Searching map preview for: scca_coop_e03_v03
2015-03-24 00:53:19,631 DEBUG    faf.downloader       Searching map preview for: souvenir.v0002
2015-03-24 00:54:19,693 DEBUG    faf.downloader       Searching map preview for: loki.v0001
2015-03-24 00:54:44,638 DEBUG    faf.downloader       Searching map preview for: bridge two far.v0003
2015-03-24 00:57:59,640 DEBUG    faf.downloader       Searching map preview for: x1mp_012
2015-03-24 00:59:54,642 DEBUG    faf.downloader       Searching map preview for: hilly jungle (the third)
2015-03-24 01:02:34,627 DEBUG    faf.downloader       Searching map preview for: voodoo mountains v6
2015-03-24 01:04:34,628 DEBUG    faf.downloader       Searching map preview for: scmp_027
2015-03-24 01:10:56,598 DEBUG    faf.downloader       Searching map preview for: scmp_0130.v0001
2015-03-24 01:12:36,585 DEBUG    faf.downloader       Searching map preview for: fields of isis 3v3
2015-03-24 01:14:31,581 DEBUG    faf.downloader       Searching map preview for: cooperative war.v0001
2015-03-24 01:16:33,030 DEBUG    faf.downloader       Searching map preview for: scmp_035
2015-03-24 01:17:18,012 DEBUG    faf.downloader       Searching map preview for: havenofwar
2015-03-24 01:18:43,016 DEBUG    faf.downloader       Searching map preview for: survival_escape_v3ga.v0001
2015-03-24 01:19:33,009 DEBUG    faf.downloader       Searching map preview for: noobmap teamplay
2015-03-24 01:24:23,154 DEBUG    faf.downloader       Searching map preview for: smokers teamplay_ai
2015-03-24 01:25:23,188 DEBUG    faf.downloader       Searching map preview for: fredouz battle 2.v0001
2015-03-24 01:26:53,183 DEBUG    faf.downloader       Searching map preview for: waters of ozone.v0002
2015-03-24 01:28:28,161 DEBUG    faf.downloader       Searching map preview for: desert siege
2015-03-24 01:35:48,561 DEBUG    faf.downloader       Searching map preview for: bunnyroadnokev1.v0001
2015-03-24 01:39:53,582 DEBUG    faf.downloader       Searching map preview for: phantom_sung_island.v0003
2015-03-24 01:39:58,555 DEBUG    faf.downloader       Searching map preview for: 10 the plain
2015-03-24 01:45:18,562 DEBUG    faf.downloader       Searching map preview for: grave passages
2015-03-24 01:46:08,562 DEBUG    faf.downloader       Searching map preview for: radiator.v0001
2015-03-24 01:46:08,585 DEBUG    faf.downloader       Searching map preview for: scca_coop_a02_v03
2015-03-24 01:46:28,555 DEBUG    faf.downloader       Searching map preview for: forbidden passv4
2015-03-24 01:47:33,592 DEBUG    faf.downloader       Searching map preview for: planetzorg.v0002
2015-03-24 01:51:38,572 DEBUG    faf.downloader       Searching map preview for: the passing.v0001
2015-03-24 02:05:24,108 DEBUG    faf.downloader       Searching map preview for: x1mp_009
2015-03-24 02:06:19,101 DEBUG    faf.downloader       Searching map preview for: scmp_030
2015-03-24 02:07:09,102 DEBUG    faf.downloader       Searching map preview for: mururoa v2
2015-03-24 02:07:19,102 DEBUG    faf.downloader       Searching map preview for: six leaf clover3.v0001
2015-03-24 02:07:24,118 DEBUG    faf.downloader       Searching map preview for: comet catcher.v0001
2015-03-24 02:08:19,101 DEBUG    faf.downloader       Searching map preview for: mako teamplay_ai
2015-03-24 02:14:59,188 DEBUG    faf.downloader       Searching map preview for: 3v3 croesus 13.v0001
2015-03-24 02:29:29,637 DEBUG    faf.downloader       Searching map preview for: the drunken pirates dance
2015-03-24 02:34:39,650 DEBUG    faf.downloader       Searching map preview for: 4v4isis.v0001
2015-03-24 02:36:59,634 DEBUG    faf.downloader       Searching map preview for: 2v4 bad cage 10x10 v1
2015-03-24 02:38:34,630 DEBUG    faf.downloader       Searching map preview for: the longest way.v0004
2015-03-24 02:42:00,726 INFO     faf.fa               fa.exe.replay(PyQt4.QtCore.QUrl(u'faflive://lobby.faforever.com/3
241275/Myronovandis.SCFAreplay?map=x1ca_coop_001_v07&mod=coop'), detach = False
2015-03-24 02:42:00,727 INFO     faf.fa               Checking FA for: coop and map x1ca_coop_001_v07
2015-03-24 02:42:00,727 INFO     faf.fa               Updating FA for mod: coop, version None
2015-03-24 02:42:00,727 DEBUG    faf.updater          Update started at 2015-03-24 02:42:00
2015-03-24 02:42:00,727 DEBUG    faf.updater          Using game path: C:\Program Files (x86)\THQ\Gas Powered Games\Sup
reme Commander - Forged Alliance
2015-03-24 02:42:00,729 DEBUG    faf.updater          Using appdata: C:\ProgramData\FAForever
2015-03-24 02:42:00,846 DEBUG    faf.updater          Connected to update server at 2015-03-24 02:42:00
2015-03-24 02:42:00,854 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAF])
2015-03-24 02:42:00,895 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 324 bytes
2015-03-24 02:42:00,895 DEBUG    faf.updater          Files to update: [ForgedAlliance.exe, init_faf.lua, init_ladder1v
1.lua, GDFBinary.dll, SupComDataPath.lua, SupComDataPathFAF.lua, init_nonxt.lua]
2015-03-24 02:42:00,898 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_nonxt.lua, 16da7063ae3309c154a2c
544f559b3a9])
2015-03-24 02:42:00,898 DEBUG    faf.updater          writeToServer(UPDATE, [bin, GDFBinary.dll, 6f57f59c2e705d7a5a02d4
9e3915cb26])
2015-03-24 02:42:00,900 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_faf.lua, f7e666f342d17e3829fc19d
bc140e4c5])
2015-03-24 02:42:00,920 DEBUG    faf.updater          writeToServer(UPDATE, [bin, ForgedAlliance.exe, dcf82138bb46628d9
9861c64d21407b7])
2015-03-24 02:42:00,921 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPath.lua, 55ac1ef97845f2291
da64b830299331e])
2015-03-24 02:42:00,921 DEBUG    faf.updater          writeToServer(UPDATE, [bin, SupComDataPathFAF.lua, 962c9d1327657d
77184adcf358c628f1])
2015-03-24 02:42:00,923 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_ladder1v1.lua, ea96ac9cec88af29c
08556c96465acfe])
2015-03-24 02:42:00,964 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 56 bytes
2015-03-24 02:42:00,964 DEBUG    faf.updater          file : init_nonxt.lua
2015-03-24 02:42:00,964 DEBUG    faf.updater          init_nonxt.lua is up to date.
2015-03-24 02:42:01,015 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2015-03-24 02:42:01,015 DEBUG    faf.updater          file : GDFBinary.dll
2015-03-24 02:42:01,015 DEBUG    faf.updater          GDFBinary.dll is up to date.
2015-03-24 02:42:01,016 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 52 bytes
2015-03-24 02:42:01,016 DEBUG    faf.updater          file : init_faf.lua
2015-03-24 02:42:01,016 DEBUG    faf.updater          init_faf.lua is up to date.
2015-03-24 02:42:01,016 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2015-03-24 02:42:01,016 DEBUG    faf.updater          file : ForgedAlliance.exe
2015-03-24 02:42:01,016 DEBUG    faf.updater          ForgedAlliance.exe is up to date.
2015-03-24 02:42:01,016 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2015-03-24 02:42:01,016 DEBUG    faf.updater          file : SupComDataPath.lua
2015-03-24 02:42:01,016 DEBUG    faf.updater          SupComDataPath.lua is up to date.
2015-03-24 02:42:01,016 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 70 bytes
2015-03-24 02:42:01,016 DEBUG    faf.updater          file : SupComDataPathFAF.lua
2015-03-24 02:42:01,016 DEBUG    faf.updater          SupComDataPathFAF.lua is up to date.
2015-03-24 02:42:01,017 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 64 bytes
2015-03-24 02:42:01,017 DEBUG    faf.updater          file : init_ladder1v1.lua
2015-03-24 02:42:01,017 DEBUG    faf.updater          init_ladder1v1.lua is up to date.
2015-03-24 02:42:01,017 DEBUG    faf.updater          Updates applied successfully.
2015-03-24 02:42:01,017 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [FAFGAMEDATA])
2015-03-24 02:42:01,059 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 352 bytes
2015-03-24 02:42:01,059 DEBUG    faf.updater          Files to update: [faforever.faf, effects.nx2, env.nx2, loc.nx2, l
ua.nx2, meshes.nx2, modules.nx2, projectiles.nx2, schook.nx2, textures.nx2, units.nx2]
2015-03-24 02:42:01,062 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, schook.nx2, 160f4ea3749dd09be54d
cbc915355a8c])
2015-03-24 02:42:01,062 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, effects.nx2, 03bedb5b662b48602c3
e5f443d4bdd80])
2015-03-24 02:42:01,063 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, modules.nx2, 5580aa219315a88af3b
6b63791cda1e7])
2015-03-24 02:42:01,065 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lua.nx2, 78bd03ad2e92d4a594e3b99
2a64eee8c])
2015-03-24 02:42:01,081 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, textures.nx2, fc10ede3cbb1479055
7803f4a69c8bec])
2015-03-24 02:42:01,082 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, env.nx2, c8e06a7315aa17c5ed7e2cc
6d6ecee99])
2015-03-24 02:42:01,082 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, meshes.nx2, e5dbdaf65e7820b60a39
8eb98136fa4c])
2015-03-24 02:42:01,101 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, faforever.faf, 51c196294638c2207
1dc8ee01e55771e])
2015-03-24 02:42:01,102 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, loc.nx2, b761276596401c04dac01c8
1463891c3])
2015-03-24 02:42:01,104 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, projectiles.nx2, a20c07ca43cab16
24cb9d75c804a3b23])
2015-03-24 02:42:01,211 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, units.nx2, 7c66db67cb2c72ffcb8e0
984915f8012])
2015-03-24 02:42:01,255 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 48 bytes
2015-03-24 02:42:01,255 DEBUG    faf.updater          file : schook.nx2
2015-03-24 02:42:01,255 DEBUG    faf.updater          schook.nx2 is up to date.
2015-03-24 02:42:01,305 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 50 bytes
2015-03-24 02:42:01,305 DEBUG    faf.updater          file : effects.nx2
2015-03-24 02:42:01,305 DEBUG    faf.updater          effects.nx2 is up to date.
2015-03-24 02:42:01,306 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 50 bytes
2015-03-24 02:42:01,306 DEBUG    faf.updater          file : modules.nx2
2015-03-24 02:42:01,306 DEBUG    faf.updater          modules.nx2 is up to date.
2015-03-24 02:42:01,306 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 42 bytes
2015-03-24 02:42:01,306 DEBUG    faf.updater          file : lua.nx2
2015-03-24 02:42:01,306 DEBUG    faf.updater          lua.nx2 is up to date.
2015-03-24 02:42:01,308 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 52 bytes
2015-03-24 02:42:01,308 DEBUG    faf.updater          file : textures.nx2
2015-03-24 02:42:01,308 DEBUG    faf.updater          textures.nx2 is up to date.
2015-03-24 02:42:01,308 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 42 bytes
2015-03-24 02:42:01,308 DEBUG    faf.updater          file : env.nx2
2015-03-24 02:42:01,308 DEBUG    faf.updater          env.nx2 is up to date.
2015-03-24 02:42:01,309 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 48 bytes
2015-03-24 02:42:01,309 DEBUG    faf.updater          file : meshes.nx2
2015-03-24 02:42:01,309 DEBUG    faf.updater          meshes.nx2 is up to date.
2015-03-24 02:42:01,309 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2015-03-24 02:42:01,309 DEBUG    faf.updater          file : faforever.faf
2015-03-24 02:42:01,309 DEBUG    faf.updater          faforever.faf is up to date.
2015-03-24 02:42:01,309 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 42 bytes
2015-03-24 02:42:01,309 DEBUG    faf.updater          file : loc.nx2
2015-03-24 02:42:01,309 DEBUG    faf.updater          loc.nx2 is up to date.
2015-03-24 02:42:01,309 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 58 bytes
2015-03-24 02:42:01,309 DEBUG    faf.updater          file : projectiles.nx2
2015-03-24 02:42:01,309 DEBUG    faf.updater          projectiles.nx2 is up to date.
2015-03-24 02:42:01,311 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 46 bytes
2015-03-24 02:42:01,311 DEBUG    faf.updater          file : units.nx2
2015-03-24 02:42:01,311 DEBUG    faf.updater          units.nx2 is up to date.
2015-03-24 02:42:01,311 DEBUG    faf.updater          Updates applied successfully.
2015-03-24 02:42:01,311 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [coop])
2015-03-24 02:42:01,354 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 74 bytes
2015-03-24 02:42:01,354 DEBUG    faf.updater          Files to update: [init_coop.lua]
2015-03-24 02:42:01,357 DEBUG    faf.updater          writeToServer(UPDATE, [bin, init_coop.lua, 589bc2dd251f0523cda234
6d5521ab2c])
2015-03-24 02:42:01,401 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 54 bytes
2015-03-24 02:42:01,401 DEBUG    faf.updater          file : init_coop.lua
2015-03-24 02:42:01,401 DEBUG    faf.updater          init_coop.lua is up to date.
2015-03-24 02:42:01,401 DEBUG    faf.updater          Updates applied successfully.
2015-03-24 02:42:01,401 DEBUG    faf.updater          writeToServer(GET_FILES_TO_UPDATE, [coopGamedata])
2015-03-24 02:42:01,443 DEBUG    faf.updater          handleAction(LIST_FILES_TO_UP) - 156 bytes
2015-03-24 02:42:01,443 DEBUG    faf.updater          Files to update: [lobby_coop.cop, lua.nx2, textures.nx2, units.nx
2]
2015-03-24 02:42:01,447 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lobby_coop.cop, 8af8305aaa1e9627
749f32b61585ad3d])
2015-03-24 02:42:01,450 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, lua.nx2, 78bd03ad2e92d4a594e3b99
2a64eee8c])
2015-03-24 02:42:01,464 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, textures.nx2, fc10ede3cbb1479055
7803f4a69c8bec])
2015-03-24 02:42:01,575 DEBUG    faf.updater          writeToServer(UPDATE, [gamedata, units.nx2, 7c66db67cb2c72ffcb8e0
984915f8012])
2015-03-24 02:42:01,617 DEBUG    faf.updater          handleAction(UP_TO_DATE) - 56 bytes
2015-03-24 02:42:01,618 DEBUG    faf.updater          file : lobby_coop.cop
2015-03-24 02:42:01,618 DEBUG    faf.updater          lobby_coop.cop is up to date.
2015-03-24 02:42:01,677 DEBUG    faf.updater          handleAction(SEND_PATCH_URL) - 226 bytes
2015-03-24 02:42:02,322 DEBUG    faf.updater          File downloaded successfully.
2015-03-24 02:42:02,869 DEBUG    faf.updater          gamedata/lua.nx2 is patched.
2015-03-24 02:42:02,871 DEBUG    faf.updater          handleAction(SEND_PATCH_URL) - 256 bytes
2015-03-24 02:42:03,799 DEBUG    faf.updater          File downloaded successfully.
2015-03-24 02:42:03,875 DEBUG    faf.updater          gamedata/textures.nx2 is patched.
2015-03-24 02:42:03,878 DEBUG    faf.updater          handleAction(SEND_PATCH_URL) - 238 bytes
2015-03-24 02:42:04,457 DEBUG    faf.updater          File downloaded successfully.
2015-03-24 02:42:04,709 DEBUG    faf.updater          gamedata/units.nx2 is patched.
2015-03-24 02:42:04,730 DEBUG    faf.updater          Updates applied successfully.
2015-03-24 02:42:04,730 DEBUG    faf.updater          Disconnected from server at 2015-03-24 02:42:04
2015-03-24 02:42:04,760 DEBUG    faf.updater          Update finished at 2015-03-24 02:42:04
2015-03-24 02:42:04,762 INFO     faf.fa               Writing fa_path.lua config file.
2015-03-24 02:42:04,767 INFO     faf.fa               Updating FA for map: x1ca_coop_001_v07
2015-03-24 02:42:08,786 INFO     faf.fa               Running FA with info: None
2015-03-24 02:42:08,788 INFO     faf.fa               Running FA via command: "C:\ProgramData\FAForever\bin\ForgedAllia
nce.exe" /replay gpgnet://lobby.faforever.com/3241275/Myronovandis.SCFAreplay /init init_coop.lua /nobugreport /log "C:
\ProgramData\FAForever\logs\replay.log" /replayid 3241275
2015-03-24 02:42:09,344 INFO     faf.client           FA has launched in an attached process.
2015-03-24 02:42:09,344 INFO     faf.client           Outgoing JSON Message: {"state": "on", "command": "fa_state"}
2015-03-24 02:42:09,344 INFO     faf.fa               Viewing Replay.
2015-03-24 02:42:14,012 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 02:42:14,012 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 02:42:14,012 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 02:42:14,012 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 02:42:14,012 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
<goes on forever>
vnznznz commented 9 years ago

I recently experienced this or a similar bug too, is it possible that the client doesn't rotate logs sometimes? My forever.log was like 50GB big , unfortunately I deleted it without looking into its contents.

vnznznz commented 9 years ago

Reproduced: Start FA Forever Lobby -> Chat Lobby -> Right Click on User "vinzBad" -> View Player Statistics -> Global Rating Evolution for the last 90 days -> Pop-Up with message "Connecting to server" hangs -> after ca. 10s the log starts to grow rapidly

2015-03-24 21:44:24,713 DEBUG    faf.downloader       Searching map preview for: waters of isis 4v4
2015-03-24 21:45:49,260 INFO     faf.client           Outgoing JSON Message: {"player": "vinzBad", "type": "global_90_days", "command": "stats"}
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:11,305 ERROR    faf.secondaryServer  Operation timed out while waiting for info.

fa_bug

vnznznz commented 9 years ago

Seems like closing the window doesn't stop https://github.com/FAForever/client/blob/432476bd8a8c1842ca86223cd3c59f6ff09a1a16/src/secondaryServer/secondaryserver.py from spamming.

2015-03-24 21:46:47,115 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,115 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:47,115 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,115 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:47,115 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,115 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation aborted while waiting for info.
2015-03-24 21:46:47,117 ERROR    faf.secondaryServer  Operation timed out while waiting for info.
Sheeo commented 9 years ago

Right.

The real problem is here: https://github.com/FAForever/client/blob/develop/src/secondaryServer/secondaryserver.py#L144

Not sure if we can do something serverside to fix this

vnznznz commented 9 years ago

I think this method should throw an error if there are too many timeouts.

anihilnine commented 9 years ago

I get this error by searching the mod vault for "plus" and have to kill the .exe via task manager

Sheeo commented 8 years ago

This is definitely solved with the new logging mechanism.