Am 12.08.2014 um 04:39 schrieb Ryan Kelly:
> On 5/08/2014 11:32 PM, [email protected] wrote:
> There should be *some* additional logging taking place from the python
> app. Are there any additional log lines in the apache error log? I
> would expect to see something along the lines of:
>
> "Authentication Failed: invalid hawk id"
>
> If not, you could try adding this to your syncserver.ini to enable
> additional logging:
>
> [loggers]
> keys = root
>
> [handlers]
> keys = console
>
> [formatters]
> keys = generic
>
> [logger_root]
> level = DEBUG
> handlers = console
>
> [handler_console]
> class = StreamHandler
> args = (sys.stdout,)
> formatter = generic
>
>
> If this doesn't show up anything, you may need to add some additional
> logging by hand. A good place to start is the "check_signature"
> function in this file:
>
> ./local/lib/python2.7/site-packages/hawkauthlib/__init__.py
>
> Add some debugging log or print statements, to see if you can confirm
> whether this function is getting invoked, whether it's returning True or
> False, and why.
>
Sorry for my late answer, I was some day out of office.
Now, I have some statements within Apache error log. See attached file.
Are these repeated messages correct?
[Thu Aug 21 20:39:10 2014] [error] Created new connection
<pymysql.connections.Connection object at 0x7f35ab418890>
[Thu Aug 21 20:39:10 2014] [error] Connection
<pymysql.connections.Connection object at 0x7f35ab418890> being returned
to pool
But we see nothing of the print statements that I have added to the file
./local/lib/python2.7/site-packages/hawkauthlib/__init__.py
How should I proceed?
Uwe
[Thu Aug 21 20:39:10 2014] [error] Created new connection
<pymysql.connections.Connection object at 0x7f35ab418890>
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab418890> being returned to pool
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab418890> rollback-on-return
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab418890> being returned to pool
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab418890> rollback-on-return
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab418890> being returned to pool
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab418890> rollback-on-return
[Thu Aug 21 20:39:10 2014] [error] Starting new HTTPS connection (1):
sync-accounts-verifier.example.com
[Thu Aug 21 20:39:10 2014] [error] "POST /v2 HTTP/1.1" 200 373
[Thu Aug 21 20:39:10 2014] [error] {"tokenserver.backend.get_user":
0.0013399124145507812, "code": 200, "request_time": 0.21716094017028809,
"remoteAddressChain": ["<client-ip-address>"], "agent": "Mozilla/5.0 (Windows
NT 5.1; rv:31.0) Gecko/20100101 Firefox/31.0", "tokenserver.assertion.verify":
0.21370315551757812, "token.assertion.verify_success": 1, "path":
"https://sync.example.com/token/1.0/sync/1.5";, "method": "GET"}
[Thu Aug 21 20:39:10 2014] [error] Created new connection
<pymysql.connections.Connection object at 0x7f35ab417890>
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab417890> being returned to pool
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab417890> rollback-on-return
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab417890> being returned to pool
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab417890> rollback-on-return
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab417890> being returned to pool
[Thu Aug 21 20:39:10 2014] [error] Connection <pymysql.connections.Connection
object at 0x7f35ab417890> rollback-on-return
[Thu Aug 21 20:39:10 2014] [error] {"code": 200, "request_time":
0.0018079280853271484, "remoteAddressChain": ["<client-ip-address>"], "agent":
"Firefox/31.0 FxSync/1.33.0.20140716183446.desktop", "path":
"https://sync.example.com/storage/1.5/3/info/collections";, "method": "GET"}
[Thu Aug 21 20:39:11 2014] [error] "POST /v2 HTTP/1.1" 200 373
[Thu Aug 21 20:39:11 2014] [error] {"tokenserver.backend.get_user":
0.0013918876647949219, "code": 200, "request_time": 0.07330513000488281,
"remoteAddressChain": ["<client-ip-address>"], "agent": "Mozilla/5.0 (Windows
NT 5.1; rv:31.0) Gecko/20100101 Firefox/31.0", "tokenserver.assertion.verify":
0.07057499885559082, "token.assertion.verify_success": 1, "path":
"https://sync.example.com/token/1.0/sync/1.5";, "method": "GET"}
_______________________________________________
Sync-dev mailing list
[email protected]
https://mail.mozilla.org/listinfo/sync-dev
