Bug 50199 - [UDM HTTP API] log 503 service unavailable
[UDM HTTP API] log 503 service unavailable
Status: CLOSED FIXED
Product: UCS
Classification: Unclassified
Component: UDM - REST API
UCS 4.4
Other Linux
: P5 normal (vote)
: ---
Assigned To: Florian Best
UMC maintainers
:
Depends on:
Blocks:
  Show dependency treegraph
 
Reported: 2019-09-16 17:59 CEST by Daniel Tröder
Modified: 2019-10-02 16:06 CEST (History)
1 user (show)

See Also:
What kind of report is it?: Development Internal
What type of bug is this?: ---
Who will be affected by this bug?: ---
How will those affected feel about the bug?: ---
User Pain:
Enterprise Customer affected?:
School Customer affected?:
ISV affected?:
Waiting Support:
Flags outvoted (downgraded) after PO Review:
Ticket number:
Bug group (optional):
Max CVSS v3 score:


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Daniel Tröder univentionstaff 2019-09-16 17:59:08 CEST
Nothing helpful is written to the log file, when an error on the server (HTTP 5xx) happens.

I just received a "HTTP 503: Service Unavailable", but the reason is unknown.
In the log file there is only:

ERROR:tornado.access:503 POST /udm/users/user/ (127.0.0.1) 13680.65ms

Add more informative information or tracebacks to the logfile to be able to analyse problems.
Comment 1 Florian Best univentionstaff 2019-09-16 18:54:56 CEST
With: ucr set directory/manager/rest/debug/level='2' directory/manager/rest/show-tracebacks='yes'
all errors tracebacks inclusive are logged and also part of the response.
→ I am changing the bug title.

This specific error happens when the subprocesses are (not yet) started.
Comment 2 Florian Best univentionstaff 2019-09-16 18:55:33 CEST
The log contains already this line:
"ERROR:tornado.access:503 GET /udm/index.html (127.0.0.1) 2.15ms"
Comment 3 Daniel Tröder univentionstaff 2019-09-17 09:02:13 CEST
(In reply to Florian Best from comment #1)
> With: ucr set directory/manager/rest/debug/level='2'
> directory/manager/rest/show-tracebacks='yes'
> all errors tracebacks inclusive are logged and also part of the response.
> → I am changing the bug title.
> 
> This specific error happens when the subprocesses are (not yet) started.
The process were all started.
No tracebacks is logged, only one line like this:

ERROR:tornado.access:503 POST /udm/users/user/ (127.0.0.1) 23438.59ms

I think it happens, when no subprocess of the main tornado process replies within a certain time. Happens when 100 clients connect at the same time.
Comment 4 Florian Best univentionstaff 2019-09-22 15:13:04 CEST
The exception is now logged.

univention-directory-manager-rest (9.0.15-8)
339c62621426 | Bug #50199: log exception when subprocesses are unreachable
Comment 5 Florian Best univentionstaff 2019-10-02 16:06:32 CEST
UCS 4.4-2 has been released:
 https://docs.software-univention.de/release-notes-4.4-2-en.html
 https://docs.software-univention.de/release-notes-4.4-2-de.html

If this error occurs again, please use "Clone This Bug".