Mobile app login fail, desktop client ok
  • I download the mobile app for iOS and Android. The login fail, but the password and the user are ok. I'm logging the api auth request body in nginx log.

    Here is the log

    Dec 21 11:28:16 liveblog sh[20638]: 11:28:16 rest.1 | GET /api status=200 time=0s size=7633b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/client_config status=200 time=0s size=571b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/ingest_providers status=200 time=0s size=189b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/preferences/5c1cb83e9a954a50bec0a45e status=200 time=0s size=5641b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/activity status=200 time=0s size=171b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/backend_meta status=200 time=0s size=256b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/users/5c1cb7f69a954a50bec0a459/desks status=200 time=0s size=203b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/roles status=200 time=0s size=1034b
    Dec 21 11:28:17 liveblog sh[20638]: 11:28:17 rest.1 | GET /api/users status=200 time=0s size=5423b
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | ERROR:eve:Exception on /api/auth [POST]
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | Traceback (most recent call last):
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1817, in wsgi_app
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     response = self.full_dispatch_request()
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1477, in full_dispatch_request
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     rv = self.handle_user_exception(e)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1381, in handle_user_exception
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     reraise(exc_type, exc_value, tb)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/_compat.py", line 33, in reraise
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     raise value
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1475, in full_dispatch_request
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     rv = self.dispatch_request()
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1461, in dispatch_request
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return self.view_functions[rule.endpoint](**req.view_args)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/endpoints.py", line 56, in collections_endpoint
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     response = post(resource)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/common.py", line 284, in rate_limited
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return f(*args, **kwargs)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/auth.py", line 79, in decorated
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return f(*args, **kwargs)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/common.py", line 1040, in decorated
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     r = f(resource, **combined_args)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/post.py", line 40, in post
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return post_internal(resource, payl, skip_validation=False)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/post.py", line 245, in post_internal
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     getattr(app, "on_insert_%s" % resource)(documents)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/events/events.py", line 77, in __call__
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     f(*a, **kw)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/src/superdesk-core/apps/auth/service.py", line 34, in on_create
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     user = self.authenticate(doc)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/src/superdesk-core/apps/auth/service.py", line 30, in authenticate
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     raise NotImplementedError()
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | NotImplementedError
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | ERROR:superdesk.errors:HTTP Exception 500 has been raised:
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | [2018-12-21 11:28:33 +0100] [20670] [ERROR] Error handling request /api/auth
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | Traceback (most recent call last):
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1817, in wsgi_app
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     response = self.full_dispatch_request()
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1477, in full_dispatch_request
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     rv = self.handle_user_exception(e)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1381, in handle_user_exception
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     reraise(exc_type, exc_value, tb)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/_compat.py", line 33, in reraise
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     raise value
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1475, in full_dispatch_request
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     rv = self.dispatch_request()
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/flask/app.py", line 1461, in dispatch_request
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return self.view_functions[rule.endpoint](**req.view_args)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/endpoints.py", line 56, in collections_endpoint
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     response = post(resource)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/common.py", line 284, in rate_limited
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return f(*args, **kwargs)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/auth.py", line 79, in decorated
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return f(*args, **kwargs)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/common.py", line 1040, in decorated
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     r = f(resource, **combined_args)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/post.py", line 40, in post
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     return post_internal(resource, payl, skip_validation=False)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/eve/methods/post.py", line 245, in post_internal
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     getattr(app, "on_insert_%s" % resource)(documents)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/events/events.py", line 77, in __call__
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     f(*a, **kw)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/src/superdesk-core/apps/auth/service.py", line 34, in on_create
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     user = self.authenticate(doc)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/src/superdesk-core/apps/auth/service.py", line 30, in authenticate
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     raise NotImplementedError()
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | NotImplementedError
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | During handling of the above exception, another exception occurred:
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 | Traceback (most recent call last):
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/gunicorn/workers/sync.py", line 135, in handle
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |     self.handle_request(listener, req, client, addr)
    Dec 21 11:28:33 liveblog sh[20638]: 11:28:33 rest.1 |   File "/opt/liveblog/env/lib/python3.5/site-packages/gunicorn/workers/sync.py", line 176, in handle_request