Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Dedimania problems. #791

Closed
TheLongLife opened this issue Dec 21, 2019 · 22 comments · Fixed by #871
Closed

Dedimania problems. #791

TheLongLife opened this issue Dec 21, 2019 · 22 comments · Fixed by #871

Comments

@TheLongLife
Copy link

TheLongLife commented Dec 21, 2019

PyPlanet fails to send the times to Dedimania in ~80% of the time and sometimes it also fails to load the records.

Expected Behavior

When the map changes or you restart the current one, the record times should be sent to Dedimania

Actual Behavior

PyPlanet fails to send the times.

Steps to Reproduce (including precondition)

  1. Get dedimania record
  2. Wait for the map to end / change the map or restart it.

Screenshot on This Problem (if possible)

This is what it looks like when it fails to send the times.
In game:
In game
Console:
In console

This is what it looks like when it fails to load the Dedimania records.

In game:
In game

Console:

ERROR    [default][pyplanet.apps.contrib.dedimania] HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)
Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 387, in _make_request
    six.raise_from(e, None)
  File "<string>", line 2, in raise_from
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 383, in _make_request
    httplib_response = conn.getresponse()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 1321, in getresponse
    response.begin()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 296, in begin
    version, status, reason = self._read_status()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 257, in _read_status
    line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\socket.py", line 589, in readinto
    return self._sock.recv_into(b)
socket.timeout: timed out

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 449, in send
    timeout=timeout
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 641, in urlopen
    _stacktrace=sys.exc_info()[2])
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\util\retry.py", line 368, in increment
    raise six.reraise(type(error), error, _stacktrace)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\packages\six.py", line 686, in reraise
    raise value
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 603, in urlopen
    chunked=chunked)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 389, in _make_request
    self._raise_timeout(err=e, url=url, timeout_value=read_timeout)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 307, in _raise_timeout
    raise ReadTimeoutError(self, url, "Read timed out. (read timeout=%s)" % timeout_value)
urllib3.exceptions.ReadTimeoutError: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 80, in execute
    res = await self.loop.run_in_executor(None, self.__request, body)
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\concurrent\futures\thread.py", line 57, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 74, in __request
    return self.client.request('POST', self.API_URL, None, body, self.headers, timeout=10)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 533, in request
    resp = self.send(prep, **send_kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 646, in send
    r = adapter.send(request, **kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 529, in send
    raise ReadTimeout(e, request=request)
requests.exceptions.ReadTimeout: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\__init__.py", line 330, in refresh_records
    server_login=self.instance.game.server_player_login
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 277, in get_map_details
    }, player_list)
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 141, in multicall
    return await self.execute('system.multicall', [{'methodName': c[0], 'params': c[1:]} for c in queries])
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 89, in execute
    raise DedimaniaTransportException(e) from e
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaTransportException: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $f00Error: Dedimania error occured!', False)

Your Environment

  • OS: Windows 10 LTSC
  • PyPlanet version: 0.7.1
  • Python version: 3.7.2
@tomvlk
Copy link
Member

tomvlk commented Dec 21, 2019

Where is your server located? Did you check your connection to the dedimania servers from your server? Could you please run this:

mtr dedimania.net
You might have to install mtr, or use the tool https://sourceforge.net/projects/winmtr/ for Windows. It seems to be a connection issue from your server.

@TheLongLife
Copy link
Author

I host the server on my home PC (I'm from Serbia)

image

Here is the result from WinMTR

@tomvlk
Copy link
Member

tomvlk commented Dec 21, 2019

Based on the data I can't figure out what it could be, it misses the data, which is not normal.
What is your upload rate?

@TheLongLife
Copy link
Author

image

@tomvlk tomvlk self-assigned this Feb 8, 2020
@tomvlk
Copy link
Member

tomvlk commented Feb 8, 2020

@TheLongLife You still suffer from this issue? Could it be related to the instability of the dedimania servers and your internet? I personally have a lower upload rate sometimes at locations and can still get it working without problems. It might be an problem with an unstable connection from your location to the dedimania api.

@TheLongLife
Copy link
Author

@TheLongLife You still suffer from this issue? Could it be related to the instability of the dedimania servers and your internet? I personally have a lower upload rate sometimes at locations and can still get it working without problems. It might be an problem with an unstable connection from your location to the dedimania api.

I haven't used the server/PyPlanet in a while (as I usually start the server only when I hunt the maps)

The last time I used it I was still having those problems.

What I can tell you is that when I tried using the EvoSC controller I haven't had the issues with records sending to Dedimania, which leads me to believe that there is no problem with my connection.

@tomvlk
Copy link
Member

tomvlk commented Apr 6, 2020

Does the map contain custom blocks/embedded blocks? There is currently a well know issue with dedimania rejecting large replays with hacked maps (maps with unlimited embedded objects or hacked validation status). @TheLongLife

@TheLongLife
Copy link
Author

Does the map contain custom blocks/embedded blocks? There is currently a well know issue with dedimania rejecting large replays with hacked maps (maps with unlimited embedded objects or hacked validation status). @TheLongLife

Hi. I've updated the PyPlanet to the latest version and I tested it again on a few maps and I haven't had the issue with PyPlanet sending the times but I still had the problem where it won't load the times when I change the map (like this https://camo.githubusercontent.com/5e537c03531b85f30d6763c27284bf03f3d2a5d8/68747470733a2f2f692e696d6775722e636f6d2f327134757649312e706e67) it loads the times when I do //res again though.

@tomvlk
Copy link
Member

tomvlk commented Apr 7, 2020

@TheLongLife Anything in the console during this error now?

@TheLongLife
Copy link
Author

I forgot to copy/screenshot the console when I got that error...from what I remember it said something about the timeout.

I just tried with like ~20 maps and I had no problems this time.

If I run into that error again I'll let you know.

@TheLongLife
Copy link
Author

TheLongLife commented Apr 9, 2020

@tomvlk

ERROR    [default][pyplanet.apps.contrib.dedimania] HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)
Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 421, in _make_request
    six.raise_from(e, None)
  File "<string>", line 3, in raise_from
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 416, in _make_request
    httplib_response = conn.getresponse()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 1321, in getresponse
    response.begin()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 296, in begin
    version, status, reason = self._read_status()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 257, in _read_status
    line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\socket.py", line 589, in readinto
    return self._sock.recv_into(b)
socket.timeout: timed out

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 449, in send
    timeout=timeout
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 720, in urlopen
    method, url, error=e, _pool=self, _stacktrace=sys.exc_info()[2]
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\util\retry.py", line 400, in increment
    raise six.reraise(type(error), error, _stacktrace)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\packages\six.py", line 735, in reraise
    raise value
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 672, in urlopen
    chunked=chunked,
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 423, in _make_request
    self._raise_timeout(err=e, url=url, timeout_value=read_timeout)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 331, in _raise_timeout
    self, url, "Read timed out. (read timeout=%s)" % timeout_value
urllib3.exceptions.ReadTimeoutError: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 80, in execute
    res = await self.loop.run_in_executor(None, self.__request, body)
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\concurrent\futures\thread.py", line 57, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 74, in __request
    return self.client.request('POST', self.API_URL, None, body, self.headers, timeout=10)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 533, in request
    resp = self.send(prep, **send_kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 646, in send
    r = adapter.send(request, **kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 529, in send
    raise ReadTimeout(e, request=request)
requests.exceptions.ReadTimeout: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\__init__.py", line 342, in refresh_records
    server_login=self.instance.game.server_player_login
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 277, in get_map_details
    }, player_list)
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 141, in multicall
    return await self.execute('system.multicall', [{'methodName': c[0], 'params': c[1:]} for c in queries])
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 89, in execute
    raise DedimaniaTransportException(e) from e
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaTransportException: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

That is what i get in the console and in the game it says : "Error: Dedimania error ocurred!"

Edit:
Annnd I got that problem where it fails to send times to dedimania...same thing as before, same error.

ERROR    [default][pyplanet.apps.contrib.dedimania] HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', "$z$s$fff»» $f00Error: Dedimania got an error, didn't send records. There might be an issue with the map or the dedimania server!", False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', "$z$s$fff»» $f00Error Details: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)", False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483885, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483886, method: None
DEBUG    [ThreadPoolExecutor-0_9][urllib3.connectionpool] Starting new HTTP connection (2): dedimania.net:8082
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483887, method: None
DEBUG    [ThreadPoolExecutor-0_9][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 832
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $0b3Current Dedimania Record: $fff\uf017 0:30.018$z$s$0b3 by $fff$F00K$F51i$FA2a$FF3X$06fSmurf$0F0$0F0 ヅ$z$s$0b3 ($l[http://dedimania.net/tm2stats/?do=stat&UId=rDisedTjRjenjywqlhC1WcKfTOj&Show=RECOR DS]$fff5$0b3 records$l)', False)

Happened on these 2 maps so far:
https://tm.mania-exchange.com/tracks/189036/sweet-short-46
https://tm.mania-exchange.com/tracks/189059/lightforged

@tomvlk
Copy link
Member

tomvlk commented Apr 13, 2020

@TheLongLife Perfect. This is what I need ;-)
I will implement some improvements to the mechanism that will retry requests when they fail. Please keep a close eye on the next major release 0.8.0, it might fix your problems. I can't fully reproduce your bug here, so it's a guess and an overal improvement of code that controls the retry mechanism.

@tomvlk
Copy link
Member

tomvlk commented May 11, 2020

@TheLongLife We narrow it down to a //restart. Can you try to see if the //replay works or doesn't work?

@TheLongLife
Copy link
Author

TheLongLife commented May 11, 2020

@TheLongLife We narrow it down to a //restart. Can you try to see if the //replay works or doesn't work?

If I do:

  1. Drive Dedi record
  2. Wait 5+minutes
  3. //replay
  4. //skip

It fails to send the record that way too even thought it says it was sent successfully in the chat.
It also failed to load the dedi records when the map was restarted (saying: "Error: Dedimania error ocurred! (Result seems to be empty!)" )

Note:
Same thing happens if I //replay and don't do //skip but just wait for map to end by itself.
Same thing happens if I don't do anything...wait for the timer to run out and the server switches to the next map automatically.

The only way for it to send the dedi record succesfully is to restart the map before 5 minutes.

Console output from the moment I type //replay:

DEBUG    [default][peewee.async] ('SELECT `t1`.`id`, `t1`.`namespace`, `t1`.`name`, `t1`.`description`, `t1`.`min_level` FROM `permission` AS t1 WHERE ((`t1`.`namespace` = %s) AND (`t1`.`name` = %s))', (['admin', 'replay'],), {})
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $ff0Admin $fff$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.$z$s$ff0 has queued this map for replay.', False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483817, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483818, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483819, method: None
DEBUG    [default][pyplanet.utils.memleak] Checking for memory leaks...
DEBUG    [default][pyplanet.utils.memleak] Checking for memory leaks...
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483820, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483821, method: None
DEBUG    [default][pyplanet.utils.memleak] Checking for memory leaks...
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerManialinkPageAnswer: (237, 'longlife', 'admin_toolbar__bar_button_skip', [])
DEBUG    [default][peewee.async] ('SELECT `t1`.`id`, `t1`.`namespace`, `t1`.`name`, `t1`.`description`, `t1`.`min_level` FROM `permission` AS t1 WHERE ((`t1`.`namespace` = %s) AND (`t1`.`name` = %s))', (['admin', 'next'],), {})
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $ff0Admin $fff$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.$z$s$ff0 has skipped to the next map.', False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483822, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndPlayLoop: {'count': 1, 'time': 1351527}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndTurn_Start: {'count': 1, 'time': 1351527}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndTurn_End: {'count': 1, 'time': 1351527}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndRound_Start: {'count': 1, 'time': 1351527}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Trackmania.Scores: {'responseid': '', 'section': 'EndRound', 'useteams': False, 'winnerteam': -1, 'winnerplayer': '', 'teams': [{'id': 0, 'name': 'Blue', 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0}, {'id': 1, 'name': 'Red', 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0}], 'players': [{'login': 'longlife', 'name': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'rank': 1, 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0, 'bestracetime': 89601, 'bestracerespawns': 0, 'bestracecheckpoints': [39984, 51320, 55862, 70899, 80164, 83468, 89601], 'bestlaptime': 89601, 'bestlaprespawns': 0, 'bestlapcheckpoints': [39984, 51320, 55862, 70899, 80164, 83468, 89601], 'stuntsscore': 3, 'prevracetime': 89601, 'prevracerespawns': 0, 'prevracecheckpoints': [39984, 51320, 55862, 70899, 80164, 83468, 89601], 'prevstuntsscore': 3}]}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndRound_End: {'count': 1, 'time': 1351527}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndMap_Start: {'count': 1, 'map': {'uid': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'name': 'short mini tech', 'filename': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'author': 'soludon', 'environment': 'Stadium', 'mood': 'Day', 'bronzetime': 54000, 'silvertime': 44000, 'goldtime': 39000, 'authortime': 35863, 'copperprice': 941, 'laprace': False, 'nblaps': 3, 'maptype': 'Race', 'mapstyle': ''}}
DEBUG    [default][root] No callback registered for Script.Maniaplanet.EndMap_Start
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483823, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Trackmania.Scores: {'responseid': '', 'section': 'EndMap', 'useteams': False, 'winnerteam': -1, 'winnerplayer': 'longlife', 'teams': [{'id': 0, 'name': 'Blue', 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0}, {'id': 1, 'name': 'Red', 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0}], 'players': [{'login': 'longlife', 'name': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'rank': 1, 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0, 'bestracetime': 89601, 'bestracerespawns': 0, 'bestracecheckpoints': [39984, 51320, 55862, 70899, 80164, 83468, 89601], 'bestlaptime': 89601, 'bestlaprespawns': 0, 'bestlapcheckpoints': [39984, 51320, 55862, 70899, 80164, 83468, 89601], 'stuntsscore': 3, 'prevracetime': 89601, 'prevracerespawns': 0, 'prevracecheckpoints': [39984, 51320, 55862, 70899, 80164, 83468, 89601], 'prevstuntsscore': 3}]}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.EndMatch: ([{'Login': 'longlife', 'NickName': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'PlayerId': 237, 'Rank': 1}], -1)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerInfoChanged: {'Login': 'longlife', 'NickName': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'PlayerId': 237, 'TeamId': -1, 'SpectatorStatus': 2551010, 'LadderRanking': 2401, 'Flags': 101000000, 'LadderScore': 10495.330078}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.Podium_Start: {'time': 1352704}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483824, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $fa0The next map will be $fffshort mini tech$z$s$fa0 as requested by $fff$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.$z$s$fa0.', False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483825, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483826, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.MapListModified: (1, 1, True)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483827, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483828, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483829, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483830, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.Podium_End: {'time': 1362709}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.ChannelProgression_Start: {'time': 1362709}
DEBUG    [default][root] No callback registered for Script.Maniaplanet.ChannelProgression_Start
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.ChannelProgression_End: {'time': 1362709}
DEBUG    [default][root] No callback registered for Script.Maniaplanet.ChannelProgression_End
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndMap_End: {'count': 1, 'time': 1362709, 'map': {'uid': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'name': 'short mini tech', 'filename': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'author': 'soludon', 'environment': 'Stadium', 'mood': 'Day', 'bronzetime': 54000, 'silvertime': 44000, 'goldtime': 39000, 'authortime': 35863, 'copperprice': 941, 'laprace': False, 'nblaps': 3, 'maptype': 'Race', 'mapstyle': ''}}
DEBUG    [default][root] No callback registered for Script.Maniaplanet.EndMap_End
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.UnloadingMap_Start: {'time': 1362709, 'map': {'uid': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'name': 'short mini tech', 'filename': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'author': 'soludon', 'environment': 'Stadium', 'mood': 'Day', 'bronzetime': 54000, 'silvertime': 44000, 'goldtime': 39000, 'authortime': 35863, 'copperprice': 941, 'laprace': False, 'nblaps': 3, 'maptype': 'Race', 'mapstyle': ''}}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.StatusChanged: (6, 'Running - Exit')
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.UnloadingMap_End: {'time': 1362755}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.EndMap: {'UId': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'Name': 'short mini tech', 'FileName': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'Author': 'soludon', 'Environnement': 'Stadium', 'Mood': 'Day', 'BronzeTime': 54000, 'SilverTime': 44000, 'GoldTime': 39000, 'AuthorTime': 35863, 'CopperPrice': 941, 'LapRace': False, 'NbLaps': 0, 'NbCheckpoints': 7, 'MapType': 'Race', 'MapStyle': ''}
DEBUG    [default][pyplanet.apps.contrib.dedimania] Sending Dedimania times...
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.StatusChanged: (2, 'Launching')
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndMatch_Start: {'count': 2, 'time': 1362785}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Trackmania.Scores: {'responseid': '', 'section': 'EndMatch', 'useteams': False, 'winnerteam': -1, 'winnerplayer': 'longlife', 'teams': [{'id': 0, 'name': 'Blue', 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0}, {'id': 1, 'name': 'Red', 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0}], 'players': [{'login': 'longlife', 'name': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'rank': 1, 'roundpoints': 0, 'mappoints': 0, 'matchpoints': 0, 'bestracetime': -1, 'bestracerespawns': -1, 'bestracecheckpoints': [], 'bestlaptime': -1, 'bestlaprespawns': -1, 'bestlapcheckpoints': [], 'stuntsscore': 0, 'prevracetime': -1, 'prevracerespawns': -1, 'prevracecheckpoints': [], 'prevstuntsscore': 0}]}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.EndMatch_End: {'count': 2, 'time': 1362785}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartMatch_Start: {'count': 3, 'time': 1362785}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartMatch_End: {'count': 3, 'time': 1362785}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.LoadingMap_Start: {'restarted': False, 'time': 1362785}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerInfoChanged: {'Login': 'longlife', 'NickName': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'PlayerId': 237, 'TeamId': -1, 'SpectatorStatus': 0, 'LadderRanking': 2401, 'Flags': 101000000, 'LadderScore': 10495.330078}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerInfoChanged: {'Login': 'longlife', 'NickName': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'PlayerId': 237, 'TeamId': -1, 'SpectatorStatus': 2551010, 'LadderRanking': 2401, 'Flags': 101000000, 'LadderScore': 10495.330078}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483831, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483832, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.MapListModified: (1, 2, False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.BeginMap: {'UId': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'Name': 'short mini tech', 'FileName': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'Author': 'soludon', 'Environnement': 'Stadium', 'Mood': 'Day', 'BronzeTime': 54000, 'SilverTime': 44000, 'GoldTime': 39000, 'AuthorTime': 35863, 'CopperPrice': 941, 'LapRace': False, 'NbLaps': 0, 'NbCheckpoints': 7, 'MapType': 'Race', 'MapStyle': ''}
DEBUG    [default][peewee.async] ('SELECT `t1`.`id`, `t1`.`created_at`, `t1`.`updated_at`, `t1`.`map_id`, `t1`.`player_id`, `t1`.`score`, `t1`.`expanded_score`, `t2`.`id`, `t2`.`created_at`, `t2`.`updated_at`, `t2`.`login`, `t2`.`nickname`, `t2`.`last_ip`, `t2`.`last_seen`, `t2`.`total_playtime`, `t2`.`total_donations`, `t2`.`level` FROM `karma` AS t1 INNER JOIN `player` AS t2 ON (`t1`.`player_id` = `t2`.`id`) WHERE (`t1`.`map_id` = %s)', ([132],), {})
DEBUG    [default][peewee.async] ('SELECT `t1`.`id`, `t1`.`created_at`, `t1`.`updated_at`, `t1`.`map_id`, `t1`.`player_id`, `t1`.`score`, `t1`.`checkpoints`, `t2`.`id`, `t2`.`created_at`, `t2`.`updated_at`, `t2`.`login`, `t2`.`nickname`, `t2`.`last_ip`, `t2`.`last_seen`, `t2`.`total_playtime`, `t2`.`total_donations`, `t2`.`level` FROM `localrecord` AS t1 INNER JOIN `player` AS t2 ON (`t1`.`player_id` = `t2`.`id`) WHERE (`t1`.`map_id` = %s) ORDER BY `t1`.`score` ASC', ([132],), {})
DEBUG    [default][peewee.async] ('SELECT `t1`.`id`, `t1`.`created_at`, `t1`.`updated_at`, `t1`.`login`, `t1`.`nickname`, `t1`.`last_ip`, `t1`.`last_seen`, `t1`.`total_playtime`, `t1`.`total_donations`, `t1`.`level` FROM `player` AS t1 WHERE (`t1`.`id` = %s)', ([1],), {})
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.StatusChanged: (3, 'Running - Synchronization')
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $ff0Current map karma: $fff0.0$ff0 ($fff0%$ff0) [$fff0$ff0 votes], MX: $fff0.0%$ff0 [$fff0$ff0 votes]', False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483833, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $0f3Current Local Record: $fff\uf017 1:29.601$z$s$0f3 by $fff$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.$z$s$0f3 ($fff1$0f3 records)', False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483834, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483835, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483836, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483837, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483838, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483839, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483840, method: None
DEBUG    [default][pyplanet.utils.memleak] Checking for memory leaks...
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.StatusChanged: (4, 'Running - Play')
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.LoadingMap_End: {'restarted': False, 'time': 1368226, 'map': {'uid': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'name': 'short mini tech', 'filename': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'author': 'soludon', 'environment': 'Stadium', 'mood': 'Day', 'bronzetime': 54000, 'silvertime': 44000, 'goldtime': 39000, 'authortime': 35863, 'copperprice': 941, 'laprace': False, 'nblaps': 3, 'maptype': 'Race', 'mapstyle': ''}}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartMap_Start: {'count': 1, 'restarted': False, 'time': 1368226, 'map': {'uid': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'name': 'short mini tech', 'filename': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'author': 'soludon', 'environment': 'Stadium', 'mood': 'Day', 'bronzetime': 54000, 'silvertime': 44000, 'goldtime': 39000, 'authortime': 35863, 'copperprice': 941, 'laprace': False, 'nblaps': 3, 'maptype': 'Race', 'mapstyle': ''}}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483841, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483842, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerInfoChanged: {'Login': 'longlife', 'NickName': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'PlayerId': 237, 'TeamId': -1, 'SpectatorStatus': 0, 'LadderRanking': 2401, 'Flags': 101000000, 'LadderScore': 10495.330078}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483843, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483844, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.BeginMatch: ()
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerInfoChanged: {'Login': 'longlife', 'NickName': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'PlayerId': 237, 'TeamId': -1, 'SpectatorStatus': 2551010, 'LadderRanking': 2401, 'Flags': 101000000, 'LadderScore': 10495.330078}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Trackmania.Event.StartCountdown: {'time': 1370018, 'login': 'longlife'}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartMap_End: {'count': 1, 'restarted': False, 'time': 1370018, 'map': {'uid': 'YNy4ofZArbpApzCGstLrqc5TZ47', 'name': 'short mini tech', 'filename': 'PyPlanet-MX\\TM-192454.Map.Gbx', 'author': 'soludon', 'environment': 'Stadium', 'mood': 'Day', 'bronzetime': 54000, 'silvertime': 44000, 'goldtime': 39000, 'authortime': 35863, 'copperprice': 941, 'laprace': False, 'nblaps': 3, 'maptype': 'Race', 'mapstyle': ''}}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartRound_Start: {'count': 1, 'time': 1370018}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartRound_End: {'count': 1, 'time': 1370018}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartTurn_Start: {'count': 1, 'time': 1370018}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartTurn_End: {'count': 1, 'time': 1370018}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Maniaplanet.StartPlayLoop: {'count': 1, 'time': 1370018}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerInfoChanged: {'Login': 'longlife', 'NickName': '$l[maniaplanet://#join=v4longserver@esl_comp@lt_forever]$fffLucid$f00.', 'PlayerId': 237, 'TeamId': -1, 'SpectatorStatus': 0, 'LadderRanking': 2401, 'Flags': 101000000, 'LadderScore': 10495.330078}
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483845, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483846, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483847, method: None
WARNING  [default][pyplanet.apps.contrib.dedimania.api] Dedimania timeout, doing a retry (retry 1 of 3)
DEBUG    [ThreadPoolExecutor-0_4][urllib3.connectionpool] Starting new HTTP connection (1): dedimania.net:8082
DEBUG    [ThreadPoolExecutor-0_4][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_9][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 375
DEBUG    [ThreadPoolExecutor-0_15][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 288
DEBUG    [ThreadPoolExecutor-0_1][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 378
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received scripted callback: Trackmania.Event.StartLine: {'time': 1373132, 'login': 'longlife'}
DEBUG    [ThreadPoolExecutor-0_17][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_12][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 380
DEBUG    [ThreadPoolExecutor-0_8][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_19][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 379
DEBUG    [ThreadPoolExecutor-0_2][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_14][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 381
DEBUG    [ThreadPoolExecutor-0_10][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_5][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 377
DEBUG    [ThreadPoolExecutor-0_16][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_7][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 379
DEBUG    [ThreadPoolExecutor-0_3][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_11][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 374
DEBUG    [ThreadPoolExecutor-0_18][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_6][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 379
DEBUG    [ThreadPoolExecutor-0_0][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 287
DEBUG    [ThreadPoolExecutor-0_13][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 380
DEBUG    [ThreadPoolExecutor-0_4][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_9][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 379
DEBUG    [ThreadPoolExecutor-0_15][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 295
DEBUG    [ThreadPoolExecutor-0_1][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 376
DEBUG    [ThreadPoolExecutor-0_17][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 295
DEBUG    [ThreadPoolExecutor-0_12][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 378
DEBUG    [ThreadPoolExecutor-0_8][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 292
DEBUG    [ThreadPoolExecutor-0_19][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 382
DEBUG    [ThreadPoolExecutor-0_2][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 292
DEBUG    [ThreadPoolExecutor-0_14][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 380
DEBUG    [ThreadPoolExecutor-0_10][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 290
DEBUG    [ThreadPoolExecutor-0_5][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 377
DEBUG    [ThreadPoolExecutor-0_16][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 438
ERROR    [default][pyplanet.apps.contrib.dedimania.api] XML-RPC Fault retrieved from Dedimania: <DedimaniaFault : 'Error in method_handler.php(702): OpenSession: too many opensession within few minutes ! Your script is buggy (ie sending opensession for each request or similar), or you are trying to use the same account on Dedimania for several servers... both are forbidden !'>
ERROR    [default][root] <DedimaniaFault : 'Error in method_handler.php(702): OpenSession: too many opensession within few minutes ! Your script is buggy (ie sending opensession for each request or similar), or you are trying to use the same account on Dedimania for several servers... both are forbidden !'>
Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 421, in _make_request
    six.raise_from(e, None)
  File "<string>", line 3, in raise_from
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 416, in _make_request
    httplib_response = conn.getresponse()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 1321, in getresponse
    response.begin()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 296, in begin
    version, status, reason = self._read_status()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 257, in _read_status
    line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\socket.py", line 589, in readinto
    return self._sock.recv_into(b)
socket.timeout: timed out

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 449, in send
    timeout=timeout
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 720, in urlopen
    method, url, error=e, _pool=self, _stacktrace=sys.exc_info()[2]
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\util\retry.py", line 400, in increment
    raise six.reraise(type(error), error, _stacktrace)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\packages\six.py", line 735, in reraise
    raise value
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 672, in urlopen
    chunked=chunked,
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 423, in _make_request
    self._raise_timeout(err=e, url=url, timeout_value=read_timeout)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 331, in _raise_timeout
    self, url, "Read timed out. (read timeout=%s)" % timeout_value
urllib3.exceptions.ReadTimeoutError: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 80, in execute
    res = await self.loop.run_in_executor(None, self.__request, body)
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\concurrent\futures\thread.py", line 57, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 74, in __request
    return self.client.request('POST', self.API_URL, None, body, self.headers, timeout=10)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 533, in request
    resp = self.send(prep, **send_kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 646, in send
    r = adapter.send(request, **kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 529, in send
    raise ReadTimeout(e, request=request)
requests.exceptions.ReadTimeout: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : 'Error in method_handler.php(702): OpenSession: too many opensession within few minutes ! Your script is buggy (ie sending opensession for each request or similar), or you are trying to use the same account on Dedimania for several servers... both are forbidden !'>
ERROR    [default][pyplanet.apps.contrib.dedimania.api] Dedimania Error during authentication: Could not retrieve data from dedimania!
DEBUG    [ThreadPoolExecutor-0_7][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 376
DEBUG    [ThreadPoolExecutor-0_3][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 436
ERROR    [default][pyplanet.apps.contrib.dedimania.api] XML-RPC Fault retrieved from Dedimania: <DedimaniaFault : 'Error in method_handler.php(702): OpenSession: too many opensession within few minutes ! Your script is buggy (ie sending opensession for each request or similar), or you are trying to use the same account on Dedimania for several servers... both are forbidden !'>
ERROR    [default][root] <DedimaniaFault : 'Error in method_handler.php(702): OpenSession: too many opensession within few minutes ! Your script is buggy (ie sending opensession for each request or similar), or you are trying to use the same account on Dedimania for several servers... both are forbidden !'>
Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 421, in _make_request
    six.raise_from(e, None)
  File "<string>", line 3, in raise_from
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 416, in _make_request
    httplib_response = conn.getresponse()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 1321, in getresponse
    response.begin()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 296, in begin
    version, status, reason = self._read_status()
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\http\client.py", line 257, in _read_status
    line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\socket.py", line 589, in readinto
    return self._sock.recv_into(b)
socket.timeout: timed out

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 449, in send
    timeout=timeout
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 720, in urlopen
    method, url, error=e, _pool=self, _stacktrace=sys.exc_info()[2]
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\util\retry.py", line 400, in increment
    raise six.reraise(type(error), error, _stacktrace)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\packages\six.py", line 735, in reraise
    raise value
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 672, in urlopen
    chunked=chunked,
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 423, in _make_request
    self._raise_timeout(err=e, url=url, timeout_value=read_timeout)
  File "C:\PYPLAN~1\env\lib\site-packages\urllib3\connectionpool.py", line 331, in _raise_timeout
    self, url, "Read timed out. (read timeout=%s)" % timeout_value
urllib3.exceptions.ReadTimeoutError: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 80, in execute
    res = await self.loop.run_in_executor(None, self.__request, body)
  File "c:\users\lucid\appdata\local\programs\python\python37-32\Lib\concurrent\futures\thread.py", line 57, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 74, in __request
    return self.client.request('POST', self.API_URL, None, body, self.headers, timeout=10)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 533, in request
    resp = self.send(prep, **send_kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\sessions.py", line 646, in send
    r = adapter.send(request, **kwargs)
  File "C:\PYPLAN~1\env\lib\site-packages\requests\adapters.py", line 529, in send
    raise ReadTimeout(e, request=request)
requests.exceptions.ReadTimeout: HTTPConnectionPool(host='dedimania.net', port=8082): Read timed out. (read timeout=10)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : "Error in method_handler.php(919): SessionId 's9574:1589208305.9285' not found !!!">

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 84, in execute
    raise DedimaniaFault(faultCode=data[0][0]['faultCode'], faultString=data[0][0]['faultString'])
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaFault: <DedimaniaFault : 'Error in method_handler.php(702): OpenSession: too many opensession within few minutes ! Your script is buggy (ie sending opensession for each request or similar), or you are trying to use the same account on Dedimania for several servers... both are forbidden !'>
ERROR    [default][pyplanet.apps.contrib.dedimania.api] Dedimania Error during authentication: Could not retrieve data from dedimania!
DEBUG    [ThreadPoolExecutor-0_11][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 379
ERROR    [default][pyplanet.apps.contrib.dedimania.api] Sending times to dedimania failed. Info: None
DEBUG    [default][peewee.async] ('SELECT `t1`.`id`, `t1`.`app`, `t1`.`key`, `t1`.`category`, `t1`.`name`, `t1`.`description`, `t1`.`value` FROM `setting` AS t1 WHERE ((`t1`.`key` = %s) AND (`t1`.`app` = %s))', (['sent_announce', 'dedimania'],), {})
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $0b3Dedimania records have been sent successfully!', False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483848, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483849, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483850, method: None
DEBUG    [ThreadPoolExecutor-0_18][urllib3.connectionpool] http://dedimania.net:8082 "POST /Dedimania HTTP/1.1" 200 373
ERROR    [default][pyplanet.apps.contrib.dedimania] Result seems to be empty!
Traceback (most recent call last):
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\__init__.py", line 356, in refresh_records
    server_login=self.instance.game.server_player_login
  File "C:\PYPLAN~1\env\lib\site-packages\pyplanet\apps\contrib\dedimania\api.py", line 283, in get_map_details
    raise DedimaniaTransportException('Result seems to be empty!')
pyplanet.apps.contrib.dedimania.exceptions.DedimaniaTransportException: Result seems to be empty!
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received callback: ManiaPlanet.PlayerChat: (0, 'v4longserver', '$z$s$fff»» $f00Error: Dedimania error occured! (Result seems to be empty!)', False)
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483851, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483852, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483853, method: None
DEBUG    [default][pyplanet.utils.memleak] Checking for memory leaks...
DEBUG    [default][pyplanet.utils.memleak] Checking for memory leaks...
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483854, method: None
DEBUG    [default][pyplanet.core.gbx.remote] GBX: Received response to handler 2147483855, method: None
DEBUG    [default][pyplanet.utils.memleak] Checking for memory leaks...```

@tomvlk
Copy link
Member

tomvlk commented May 13, 2020

Thank you for the details, 0.8.0 is ready for release, I will make this part of the first bugfix version 0.8.1 because I need more time to investigate and narrowing down in the code. Thank you very very much for the detailed reports

@Harest
Copy link

Harest commented May 17, 2020

Regarding these issues with Dedimania, i'm not much on servers so i don't notice them much. Though i played and finished several times a RPG map along many others players and apparently no record has been sent to Dedimania :/.
I'm curious, does the connection reset to Dedimania (e.g.: [2020-05-16 21:59:31,554][DEBUG][ThreadPoolExecutor-0_8] urllib3.connectionpool: Resetting dropped connection: dedimania.net (connectionpool.py:266)) can be a cause too? Since debug is set to false i don't have much in the logs.
It was the map Mushroom Islland, on _Harest_RPG. And if i didn't miss it the map was finally switched at +/- 2020-05-17 00:17:21. Map changed at 2020/05/16 22:28:16. What is strange though is that there's no trace of any vote anywhere (GameLog/ConsoleLog). And the ConsoleLog indicates this at this exact time :

[2020/05/16 22:28:16] Disconnection of eradicateur(**********:2350)
[2020/05/16 22:28:16] ...Finish
[2020/05/16 22:28:16] ...Exit
[2020/05/16 22:28:16] Script 'Mode:TimeAttack': [LOG]1792087881> [Log] Logs are disabled in the "production" environment.

[2020/05/16 22:28:16] Loading map TM-193475.Map.Gbx (RWIfK5ppyvWs7SGX2WXEEXBDOo8)...

May not be too strange, seems to occur often and be the standard behavior if a map was played for 6+ hours when the last player disconnects it instantly switches. Maybe this is a part of the issue though? That Pyplanet doesn't handle properly the records upload to Dedimania when Maniaplanet does the "at least 6h played map & no more player switch". Not tied to the issue the OP has though, but if it can help to fix one of the Dedimania issues, always good i guess.

Update: A new case confirms the issue with what i described in the previous § with that "at least 6h played map & no more player switch". I added a new RPG map on 2 servers. The map was played on one of them (_Harest_RPG_Beg) from 2020/05/19 18:46:37 to 2020/05/20 02:02:46 (GMT+2 ; when the last player left). 53 players finished the map during that time. No record was updated to Dedimania despite at least 37 should have (it's a maxed server on Dedimania so top 80 is registered, and only 43 records atm).

[2020/05/19 18:46:37] Loading map TM-157308.Map.Gbx (fI5KKartx0Nbg8agm5jZzvTzVy1)...
...
[2020/05/20 02:02:46] <chat> [_harest_rpg_beg ($i$s$o$e10RPG$g - $5f0Beginners$g $f40O$f30n$f20l$f10y$g)] $z$s$fff»» $ff0Player $fff$i$F00L$A00o$500u$000d〢$fffTaak$F60ै〢$39Fฟ$56Fє$83Fє$A0FЬ$z$s$ff0 left the server! Nation: $fffFrance
[2020/05/20 02:02:46] Loading map TM-53845.Map.Gbx (imUKyKZmuQP422HSoDdfv2VU9dl)...

@tomvlk tomvlk modified the milestones: Version 0.8.1, Version 0.8.2 May 18, 2020
@tomvlk tomvlk modified the milestones: Version 0.9.2, Version 0.9.3 Jul 8, 2020
@zerofixgiven
Copy link
Contributor

I've also been encoutering this issue quite often on my servers running PyPlanet Version 0.9.2.

My moderators told me that they noticed that the issue does also happen especially when the time is extended by //extend or vote.

I did also notice, that the servers are often shown as offline on http://dedimania.net/tm2stats/?do=stat maybe that has something to do with it.

@TheMaximum
Copy link
Member

TheMaximum commented Oct 30, 2020

Looks like the update loop - sending current server information to Dedimania every four minutes - did not work correctly (it got blocked on retrieving the maximum players/spectators).
I'm not certain my PR will fix this issue, but it should help with issues of servers showing as offline (f.e. after extending the timelimit, or having along timelimit).

@zerofixgiven
Copy link
Contributor

zerofixgiven commented Oct 30, 2020

Since it's been a while, I want to give some new feedback.

We haven't really been encountering this issue a lot or at all anymore.

BUT the interesting thing is that we didn't run into the issue anymore (or maybe so rare that no one of my moderators and myself noticed it), after our server accounts were upgraded to unlock claming top 80 dedimania records.

@Harest
Copy link

Harest commented Oct 31, 2020

Cf. my message above, there's at least the case where Pyplanet doesn't send anything when ManiaPlanet switch the map with the condition: "at least 6h played map (just need a no time limit server for it to always happen) & no more player on the server" that would still need to be solved if possible. Not related to the OP issue directly though. Just a regular case on RPG servers.

@zerofixgiven
Copy link
Contributor

What I wanted to say with my comment above is that we didn't have an issue anymore with extending the map time and having records not being sent, it's weird that it didn't occure anymore after the server were upgraded.

I did just dig through some of the servers logs. The timeout error is still there.

Here is the log of one of my servers since the upgrade to 0.9.5: https://pastebin.com/ZrUgGuhC

@tomvlk
Copy link
Member

tomvlk commented Feb 5, 2022

For now we can not reproduce this error, please reopen a new case if this persists.

@tomvlk tomvlk closed this as completed Feb 5, 2022
@tomvlk tomvlk modified the milestones: Version 0.9.13, Version 0.9.14 Mar 12, 2022
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

Successfully merging a pull request may close this issue.

5 participants