Attachment 7726 Details for Bug 41491 – console-web-server.log

console-web-server.log

management-console-web-server.log (text/plain), 15.61 KB, created by Jürn Brodersen on 2016-06-08 14:15:45 CEST

(hide)

Description:

Filename:

MIME Type:

Creator: Jürn Brodersen

Created: 2016-06-08 14:15:45 CEST

Size: 15.61 KB

patch

obsolete

>08.06.16 12:44:32.404  DEBUG_INIT
>08.06.16 12:44:32.444  MAIN        ( PROCESS ) : Stopping UMC web server ...
>08.06.16 12:44:32.459  MAIN        ( PROCESS ) : The UMC web server is still running. Will wait for 5 seconds
>08.06.16 12:44:32.961  MAIN        ( PROCESS ) : Starting UMC web server ...
>08.06.16 12:44:34.275  MAIN        ( INFO    ) : Reloading SAML service provider configuration
>08.06.16 12:45:12.582  MAIN        ( INFO    ) : CPAuth/auth: got new auth request (::1:58191 <=> )
>08.06.16 12:45:12.585  MAIN        ( INFO    ) : auth: request: command=/auth
>08.06.16 12:45:12.590  MAIN        ( INFO    ) : CPAuth (::1:58191) found sessionid
>08.06.16 12:45:12.591  MAIN        ( INFO    ) : CPAuth (::1:58191) sessionid='dde65cdc-2453-4637-ae31-0efc6297eed8'
>08.06.16 12:45:12.609  MAIN        ( INFO    ) : CPAuth (::1:58191) found sessionid
>08.06.16 12:45:12.610  MAIN        ( INFO    ) : CPAuth (::1:58191) sessionid='dde65cdc-2453-4637-ae31-0efc6297eed8'
>08.06.16 12:45:12.610  MAIN        ( INFO    ) : auth: pushed request to queue - waiting for response
>08.06.16 12:45:12.703  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new request: 0x231b210
>08.06.16 12:45:12.703  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: AUTH request
>08.06.16 12:45:12.703  MAIN        ( INFO    ) : SessionClient(0x231b2d0): creating new session
>08.06.16 12:45:12.790  MAIN        ( INFO    ) : Client.connect: SSL connection established
>08.06.16 12:45:12.791  MAIN        ( INFO    ) : SessionClient(0x231b2d0): connected to UMC server
>08.06.16 12:45:12.791  MAIN        ( INFO    ) : SessionClient(0x231b2d0): authenticate_user: sending authentication request for user u'__systemsetup__'
>08.06.16 12:45:12.792  PROTOCOL    ( INFO    ) : Sending UMCP AUTH REQUEST 146538271260747-0
>08.06.16 12:45:12.894  MAIN        ( INFO    ) : __verify_cert_cb: Got certificate subject: <X509Name object '/C=DE/ST=DE/L=DE/O=DE/OU=Univention Corporate Server/CN=Univention Corporate Server Root CA (ID=iBR9U6NY)/emailAddress=ssl@'>
>08.06.16 12:45:12.898  MAIN        ( INFO    ) : __verify_cert_cb: Got certificate issuer: <X509Name object '/C=DE/ST=DE/L=DE/O=DE/OU=Univention Corporate Server/CN=Univention Corporate Server Root CA (ID=iBR9U6NY)/emailAddress=ssl@'>
>08.06.16 12:45:12.899  MAIN        ( INFO    ) : __verify_cert_cb: errnum=0 depth=1 ok=1
>08.06.16 12:45:12.918  MAIN        ( INFO    ) : __verify_cert_cb: Got certificate subject: <X509Name object '/C=DE/ST=DE/L=DE/O=DE/OU=Univention Corporate Server/CN=unassigned-hostname.unassigned-domain/emailAddress=ssl@'>
>08.06.16 12:45:12.918  MAIN        ( INFO    ) : __verify_cert_cb: Got certificate issuer: <X509Name object '/C=DE/ST=DE/L=DE/O=DE/OU=Univention Corporate Server/CN=Univention Corporate Server Root CA (ID=iBR9U6NY)/emailAddress=ssl@'>
>08.06.16 12:45:12.918  MAIN        ( INFO    ) : __verify_cert_cb: errnum=0 depth=0 ok=1
>08.06.16 12:45:13.852  PARSER      ( INFO    ) : UMCP RESPONSE 146538271260747-0 parsed successfully
>08.06.16 12:45:13.853  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 146538271260747-0
>08.06.16 12:45:13.853  MAIN        ( PROCESS ) : SessionClient(0x231b2d0): _authenticated: success=True  status=200  message=None
>08.06.16 12:45:13.860  MAIN        ( INFO    ) : auth: got response with status 200
>08.06.16 12:45:13.861  MAIN        ( INFO    ) : auth: creating session with sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:13.863  MAIN        ( INFO    ) : CPAuth (::1:58191) found sessionid
>08.06.16 12:45:13.864  MAIN        ( INFO    ) : CPAuth (::1:58191) sessionid='dde65cdc-2453-4637-ae31-0efc6297eed8'
>08.06.16 12:45:14.734  MAIN        ( INFO    ) : CPSet (::1:58194) got new request
>08.06.16 12:45:14.739  MAIN        ( INFO    ) : CPSet (::1:58194) found sessionid
>08.06.16 12:45:14.739  MAIN        ( INFO    ) : CPSet (::1:58194) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:14.740  MAIN        ( INFO    ) : CPSet (::1:58194) found sessionid
>08.06.16 12:45:14.741  MAIN        ( INFO    ) : CPSet (::1:58194) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:14.749  MAIN        ( INFO    ) : CPSet (::1:58194) found sessionid
>08.06.16 12:45:14.749  MAIN        ( INFO    ) : CPSet (::1:58194) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:14.755  MAIN        ( INFO    ) : CPSet (::1:58194) queue(0x2314f80): sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:14.763  MAIN        ( INFO    ) : CPSet (::1:58194) pushed request(0x2311b50) to queue(0x2314f80) - waiting for response
>08.06.16 12:45:14.779  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new request: 0x231b1d0
>08.06.16 12:45:14.780  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>08.06.16 12:45:14.780  MAIN        ( INFO    ) : SessionClient(0x231b2d0): sending request(146538271474781-1)
>08.06.16 12:45:14.780  PROTOCOL    ( INFO    ) : Sending UMCP SET REQUEST 146538271474781-1
>08.06.16 12:45:15.429  PARSER      ( INFO    ) : UMCP RESPONSE 146538271474781-1 parsed successfully
>08.06.16 12:45:15.429  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 146538271474781-1
>08.06.16 12:45:15.429  MAIN        ( INFO    ) : SessionClient(0x231b2d0): got response(146538271474781-1): status=200 queue=0x2314f80
>08.06.16 12:45:15.431  MAIN        ( INFO    ) : CPSet (::1:58194) got response(0x231b290) from queue(0x2314f80): status=200
>08.06.16 12:45:16.973  MAIN        ( INFO    ) : CPGet (::1:58195) got new request
>08.06.16 12:45:16.979  MAIN        ( INFO    ) : CPGet (::1:58195) found sessionid
>08.06.16 12:45:16.979  MAIN        ( INFO    ) : CPGet (::1:58195) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:16.979  MAIN        ( INFO    ) : CPGet (::1:58195) found sessionid
>08.06.16 12:45:16.980  MAIN        ( INFO    ) : CPGet (::1:58195) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:16.988  MAIN        ( INFO    ) : CPGet (::1:58195) found sessionid
>08.06.16 12:45:16.988  MAIN        ( INFO    ) : CPGet (::1:58195) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:16.989  MAIN        ( INFO    ) : CPGet (::1:58195) queue(0x231a7a0): sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:16.989  MAIN        ( INFO    ) : CPGet (::1:58195) pushed request(0x2311c10) to queue(0x231a7a0) - waiting for response
>08.06.16 12:45:16.995  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new request: 0x231b550
>08.06.16 12:45:16.996  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>08.06.16 12:45:16.996  MAIN        ( INFO    ) : SessionClient(0x231b2d0): sending request(146538271698181-2)
>08.06.16 12:45:16.996  PROTOCOL    ( INFO    ) : Sending UMCP GET REQUEST 146538271698181-2
>08.06.16 12:45:17.118  PARSER      ( INFO    ) : UMCP RESPONSE 146538271698181-2 parsed successfully
>08.06.16 12:45:17.119  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 146538271698181-2
>08.06.16 12:45:17.119  MAIN        ( INFO    ) : SessionClient(0x231b2d0): got response(146538271698181-2): status=200 queue=0x231a7a0
>08.06.16 12:45:17.120  MAIN        ( INFO    ) : CPGet (::1:58195) got response(0x231b690) from queue(0x231a7a0): status=200
>08.06.16 12:45:17.359  MAIN        ( INFO    ) : CPGet (::1:58196) got new request
>08.06.16 12:45:17.360  MAIN        ( INFO    ) : CPGet (::1:58196) found sessionid
>08.06.16 12:45:17.360  MAIN        ( INFO    ) : CPGet (::1:58196) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.360  MAIN        ( INFO    ) : CPGet (::1:58196) found sessionid
>08.06.16 12:45:17.360  MAIN        ( INFO    ) : CPGet (::1:58196) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.366  MAIN        ( INFO    ) : CPGet (::1:58196) found sessionid
>08.06.16 12:45:17.370  MAIN        ( INFO    ) : CPGet (::1:58196) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.377  MAIN        ( INFO    ) : CPGet (::1:58196) queue(0x231a7e8): sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.378  MAIN        ( INFO    ) : CPGet (::1:58196) pushed request(0x2311ed0) to queue(0x231a7e8) - waiting for response
>08.06.16 12:45:17.436  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new request: 0x231b590
>08.06.16 12:45:17.436  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>08.06.16 12:45:17.436  MAIN        ( INFO    ) : SessionClient(0x231b2d0): sending request(146538271736207-3)
>08.06.16 12:45:17.436  PROTOCOL    ( INFO    ) : Sending UMCP GET REQUEST 146538271736207-3
>08.06.16 12:45:17.675  PARSER      ( INFO    ) : UMCP RESPONSE 146538271736207-3 parsed successfully
>08.06.16 12:45:17.676  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 146538271736207-3
>08.06.16 12:45:17.676  MAIN        ( INFO    ) : SessionClient(0x231b2d0): got response(146538271736207-3): status=200 queue=0x231a7e8
>08.06.16 12:45:17.681  MAIN        ( INFO    ) : CPGet (::1:58196) got response(0x231b8d0) from queue(0x231a7e8): status=200
>08.06.16 12:45:17.796  MAIN        ( INFO    ) : CPGet (::1:58197) got new request
>08.06.16 12:45:17.797  MAIN        ( INFO    ) : CPGet (::1:58197) found sessionid
>08.06.16 12:45:17.798  MAIN        ( INFO    ) : CPGet (::1:58197) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.803  MAIN        ( INFO    ) : CPGet (::1:58197) found sessionid
>08.06.16 12:45:17.803  MAIN        ( INFO    ) : CPGet (::1:58197) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.805  MAIN        ( INFO    ) : CPGet (::1:58197) found sessionid
>08.06.16 12:45:17.806  MAIN        ( INFO    ) : CPGet (::1:58197) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.809  MAIN        ( INFO    ) : CPGet (::1:58197) queue(0x231a5f0): sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:17.809  MAIN        ( INFO    ) : CPGet (::1:58197) pushed request(0x2311c10) to queue(0x231a5f0) - waiting for response
>08.06.16 12:45:17.893  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new request: 0x231b8d0
>08.06.16 12:45:17.893  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>08.06.16 12:45:17.893  MAIN        ( INFO    ) : SessionClient(0x231b2d0): sending request(146538271780481-4)
>08.06.16 12:45:17.893  PROTOCOL    ( INFO    ) : Sending UMCP GET REQUEST 146538271780481-4
>08.06.16 12:45:18.076  PARSER      ( INFO    ) : UMCP RESPONSE 146538271780481-4 parsed successfully
>08.06.16 12:45:18.076  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 146538271780481-4
>08.06.16 12:45:18.076  MAIN        ( INFO    ) : SessionClient(0x231b2d0): got response(146538271780481-4): status=200 queue=0x231a5f0
>08.06.16 12:45:18.079  MAIN        ( INFO    ) : CPGet (::1:58197) got response(0x231b810) from queue(0x231a5f0): status=200
>08.06.16 12:45:27.219  MAIN        ( INFO    ) : CPGet (::1:58199) got new request
>08.06.16 12:45:27.220  MAIN        ( INFO    ) : CPGet (::1:58199) found sessionid
>08.06.16 12:45:27.220  MAIN        ( INFO    ) : CPGet (::1:58199) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.220  MAIN        ( INFO    ) : CPGet (::1:58199) found sessionid
>08.06.16 12:45:27.231  MAIN        ( INFO    ) : CPGet (::1:58199) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.233  MAIN        ( INFO    ) : CPGet (::1:58199) found sessionid
>08.06.16 12:45:27.234  MAIN        ( INFO    ) : CPGet (::1:58199) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.239  MAIN        ( INFO    ) : CPGet (::1:58199) queue(0x231a290): sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.240  MAIN        ( INFO    ) : CPGet (::1:58199) pushed request(0x2311c90) to queue(0x231a290) - waiting for response
>08.06.16 12:45:27.304  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new request: 0x231b850
>08.06.16 12:45:27.304  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>08.06.16 12:45:27.304  MAIN        ( INFO    ) : SessionClient(0x231b2d0): sending request(146538272723269-5)
>08.06.16 12:45:27.305  PROTOCOL    ( INFO    ) : Sending UMCP GET REQUEST 146538272723269-5
>08.06.16 12:45:27.465  PARSER      ( INFO    ) : UMCP RESPONSE 146538272723269-5 parsed successfully
>08.06.16 12:45:27.466  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 146538272723269-5
>08.06.16 12:45:27.466  MAIN        ( INFO    ) : SessionClient(0x231b2d0): got response(146538272723269-5): status=200 queue=0x231a290
>08.06.16 12:45:27.468  MAIN        ( INFO    ) : CPGet (::1:58199) got response(0x231b8d0) from queue(0x231a290): status=200
>08.06.16 12:45:27.640  MAIN        ( INFO    ) : CPCommand (::1:58200) got new request
>08.06.16 12:45:27.641  MAIN        ( INFO    ) : CPCommand (::1:58200) found sessionid
>08.06.16 12:45:27.641  MAIN        ( INFO    ) : CPCommand (::1:58200) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.641  MAIN        ( INFO    ) : CPCommand (::1:58200) found sessionid
>08.06.16 12:45:27.642  MAIN        ( INFO    ) : CPCommand (::1:58200) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.649  MAIN        ( INFO    ) : CPCommand (::1:58200) found sessionid
>08.06.16 12:45:27.650  MAIN        ( INFO    ) : CPCommand (::1:58200) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.655  MAIN        ( INFO    ) : CPCommand (::1:58200) queue(0x231a758): sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:45:27.655  MAIN        ( INFO    ) : CPCommand (::1:58200) pushed request(0x2311c50) to queue(0x231a758) - waiting for response
>08.06.16 12:45:27.679  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new request: 0x231b850
>08.06.16 12:45:27.680  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>08.06.16 12:45:27.680  MAIN        ( INFO    ) : SessionClient(0x231b2d0): sending request(146538272764827-6)
>08.06.16 12:45:27.680  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 146538272764827-6
>08.06.16 12:45:37.831  PARSER      ( INFO    ) : UMCP RESPONSE 146538272764827-6 parsed successfully
>08.06.16 12:45:37.832  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 146538272764827-6
>08.06.16 12:45:37.832  MAIN        ( INFO    ) : SessionClient(0x231b2d0): got response(146538272764827-6): status=511 queue=0x231a758
>08.06.16 12:45:37.835  MAIN        ( INFO    ) : CPCommand (::1:58200) got response(0x231b7d0) from queue(0x231a758): status=511
>08.06.16 12:45:37.836  MAIN        ( PROCESS ) : CPCommand (::1:58200) response status code: 511
>08.06.16 12:45:37.836  MAIN        ( PROCESS ) : CPCommand (::1:58200) response message: Connection to module process failed
>08.06.16 12:45:37.836  MAIN        ( PROCESS ) : CPCommand (::1:58200) response result: None
>08.06.16 12:45:46.763  MAIN        ( INFO    ) : CPGet (::1:58204) found sessionid
>08.06.16 12:45:46.763  MAIN        ( INFO    ) : CPGet (::1:58204) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:46:16.756  MAIN        ( INFO    ) : CPGet (::1:58206) found sessionid
>08.06.16 12:46:16.757  MAIN        ( INFO    ) : CPGet (::1:58206) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:46:46.779  MAIN        ( INFO    ) : CPGet (::1:58208) found sessionid
>08.06.16 12:46:46.779  MAIN        ( INFO    ) : CPGet (::1:58208) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:47:16.761  MAIN        ( INFO    ) : CPGet (::1:58210) found sessionid
>08.06.16 12:47:16.761  MAIN        ( INFO    ) : CPGet (::1:58210) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:47:46.798  MAIN        ( INFO    ) : CPGet (::1:58212) found sessionid
>08.06.16 12:47:46.799  MAIN        ( INFO    ) : CPGet (::1:58212) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'
>08.06.16 12:48:16.799  MAIN        ( INFO    ) : CPGet (::1:58214) found sessionid
>08.06.16 12:48:16.799  MAIN        ( INFO    ) : CPGet (::1:58214) sessionid='580bab2a-d4e7-40a5-b6f0-3e87a6ca6a5d'

Actions: View

Attachments on bug 41491: 7725 | 7726 | 7727