Attachment 3481 Details for Bug 23430

management-console-web-server.log

management-console-web-server.log (text/plain), 46.41 KB, created by Stefan Gohmann on 2011-08-26 07:07 CEST

(hide)

Description:

Filename:

MIME Type:

Creator: Stefan Gohmann

Created: 2011-08-26 07:07 CEST

Size: 46.41 KB

patch

obsolete

>25.08.11 22:10:30.147  DEBUG_INIT
>25.08.11 22:10:52.941  MAIN        ( INFO    ) : CPRoot/auth: got new auth request (127.0.0.1:55452 <=> )
>25.08.11 22:10:52.942  MAIN        ( INFO    ) : CPRoot/command: request: command=/auth
>25.08.11 22:10:52.942  MAIN        ( INFO    ) : CPRoot/auth: pushed request to queue - waiting for response
>25.08.11 22:10:53.026  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:10:53.026  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: AUTH request
>25.08.11 22:10:53.026  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: creating new sessionid
>25.08.11 22:10:53.027  MAIN        ( INFO    ) : SessionClient: creating new session
>25.08.11 22:10:53.028  MAIN        ( INFO    ) : Client.connect: SSL connection established
>25.08.11 22:10:53.028  MAIN        ( ERROR   ) : SessionClient: connection to UMC server failed
>25.08.11 22:10:53.029  MAIN        ( INFO    ) : SessionClient: authenticate_user: sending authentication request for user Administrator
>25.08.11 22:10:53.029  PROTOCOL    ( INFO    ) : Sending UMCP AUTH REQUEST 131430305302928-1
>25.08.11 22:10:53.030  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/emailAddress=ssl@deadlock5.local'>
>25.08.11 22:10:53.030  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/emailAddress=ssl@deadlock5.local'>
>25.08.11 22:10:53.030  MAIN        ( INFO    ) : __verify_cert_cb: errnum=0  depth=1	 ok=1
>25.08.11 22:10:53.031  MAIN        ( INFO    ) : __verify_cert_cb: Got certificate subject: <X509Name object '/C=de/ST=de/L=de/O=de/OU=Univention Corporate Server/CN=master5.deadlock5.local/emailAddress=ssl@deadlock5.local'>
>25.08.11 22:10:53.031  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/emailAddress=ssl@deadlock5.local'>
>25.08.11 22:10:53.031  MAIN        ( INFO    ) : __verify_cert_cb: errnum=0  depth=0	 ok=1
>25.08.11 22:10:53.136  PARSER      ( INFO    ) : UMCP RESPONSE 131430305302928-1 parsed successfully
>25.08.11 22:10:53.136  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430305302928-1
>25.08.11 22:10:53.136  MAIN        ( ERROR   ) : SessionClient: _authenticated: success=True  status=200  message=OK, operation successful
>25.08.11 22:10:53.136  MAIN        ( INFO    ) : CPRoot/auth: got response with status 200
>25.08.11 22:10:53.136  MAIN        ( INFO    ) : CPRoot/auth: creating cookie with sessionid=006d71f1-6406-4b80-a39f-30f80dd71d1a
>25.08.11 22:10:53.198  MAIN        ( INFO    ) : CPSet (127.0.0.1:55454) got new request
>25.08.11 22:10:53.198  MAIN        ( INFO    ) : CPSet (127.0.0.1:55454) found sessionid
>25.08.11 22:10:53.198  MAIN        ( INFO    ) : CPSet (127.0.0.1:55454) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:10:53.198  MAIN        ( INFO    ) : CPSet (127.0.0.1:55454) pushed request 131430305319881-2 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:10:53.236  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:10:53.236  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:10:53.236  MAIN        ( INFO    ) : SessionClient: sending request with id=131430305319881-2
>25.08.11 22:10:53.236  PROTOCOL    ( INFO    ) : Sending UMCP SET REQUEST 131430305319881-2
>25.08.11 22:10:53.302  PARSER      ( INFO    ) : UMCP RESPONSE 131430305319881-2 parsed successfully
>25.08.11 22:10:53.302  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430305319881-2
>25.08.11 22:10:53.302  MAIN        ( INFO    ) : SessionClient: got response with id=131430305319881-2 and status=200
>25.08.11 22:10:53.302  MAIN        ( INFO    ) : CPSet (127.0.0.1:55454) got response 131430305319881-2 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:10:53.352  MAIN        ( INFO    ) : CPGet (127.0.0.1:55456) got new request
>25.08.11 22:10:53.352  MAIN        ( INFO    ) : CPGet (127.0.0.1:55456) found sessionid
>25.08.11 22:10:53.352  MAIN        ( INFO    ) : CPGet (127.0.0.1:55456) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:10:53.352  MAIN        ( INFO    ) : CPGet (127.0.0.1:55456) pushed request 131430305335214-3 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:10:53.402  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:10:53.402  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:10:53.403  MAIN        ( INFO    ) : SessionClient: sending request with id=131430305335214-3
>25.08.11 22:10:53.403  PROTOCOL    ( INFO    ) : Sending UMCP GET REQUEST 131430305335214-3
>25.08.11 22:10:53.406  PARSER      ( INFO    ) : UMCP RESPONSE 131430305335214-3 parsed successfully
>25.08.11 22:10:53.406  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430305335214-3
>25.08.11 22:10:53.406  MAIN        ( INFO    ) : SessionClient: got response with id=131430305335214-3 and status=200
>25.08.11 22:10:53.406  MAIN        ( INFO    ) : CPGet (127.0.0.1:55456) got response 131430305335214-3 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:10:57.788  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55457) got new request
>25.08.11 22:10:57.788  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55457) found sessionid
>25.08.11 22:10:57.788  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55457) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:10:57.788  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55457) pushed request 131430305778885-4 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:10:57.816  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:10:57.816  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:10:57.816  MAIN        ( INFO    ) : SessionClient: sending request with id=131430305778885-4
>25.08.11 22:10:57.816  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430305778885-4
>25.08.11 22:10:58.159  PARSER      ( INFO    ) : UMCP RESPONSE 131430305778885-4 parsed successfully
>25.08.11 22:10:58.159  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430305778885-4
>25.08.11 22:10:58.159  MAIN        ( INFO    ) : SessionClient: got response with id=131430305778885-4 and status=200
>25.08.11 22:10:58.160  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55457) got response 131430305778885-4 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:02.177  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55459) got new request
>25.08.11 22:11:02.177  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55459) found sessionid
>25.08.11 22:11:02.177  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55459) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:02.178  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55459) pushed request 131430306217802-5 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:02.179  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55460) got new request
>25.08.11 22:11:02.179  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55460) found sessionid
>25.08.11 22:11:02.179  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55460) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:02.179  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55460) pushed request 131430306217969-6 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:02.179  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55458) got new request
>25.08.11 22:11:02.179  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55458) found sessionid
>25.08.11 22:11:02.179  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55458) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:02.180  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55458) pushed request 131430306217997-7 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306217802-5
>25.08.11 22:11:02.268  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306217802-5
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306217969-6
>25.08.11 22:11:02.268  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306217969-6
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:02.268  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306217997-7
>25.08.11 22:11:02.268  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306217997-7
>25.08.11 22:11:02.438  PARSER      ( INFO    ) : UMCP RESPONSE 131430306217802-5 parsed successfully
>25.08.11 22:11:02.438  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306217802-5
>25.08.11 22:11:02.438  MAIN        ( INFO    ) : SessionClient: got response with id=131430306217802-5 and status=200
>25.08.11 22:11:02.438  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55459) got response 131430306217802-5 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:02.781  PARSER      ( INFO    ) : UMCP RESPONSE 131430306217969-6 parsed successfully
>25.08.11 22:11:02.782  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306217969-6
>25.08.11 22:11:02.782  MAIN        ( INFO    ) : SessionClient: got response with id=131430306217969-6 and status=200
>25.08.11 22:11:02.782  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55460) got response 131430306217969-6 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:02.784  PARSER      ( INFO    ) : UMCP RESPONSE 131430306217997-7 parsed successfully
>25.08.11 22:11:02.784  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306217997-7
>25.08.11 22:11:02.784  MAIN        ( INFO    ) : SessionClient: got response with id=131430306217997-7 and status=200
>25.08.11 22:11:02.784  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55458) got response 131430306217997-7 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.093  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55462) got new request
>25.08.11 22:11:03.093  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55462) found sessionid
>25.08.11 22:11:03.093  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55462) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:03.094  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55462) pushed request 131430306309313-8 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.185  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:03.185  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:03.185  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306309313-8
>25.08.11 22:11:03.185  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306309313-8
>25.08.11 22:11:03.187  PARSER      ( INFO    ) : UMCP RESPONSE 131430306309313-8 parsed successfully
>25.08.11 22:11:03.187  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306309313-8
>25.08.11 22:11:03.187  MAIN        ( INFO    ) : SessionClient: got response with id=131430306309313-8 and status=200
>25.08.11 22:11:03.187  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55462) got response 131430306309313-8 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.234  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55463) got new request
>25.08.11 22:11:03.234  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55463) found sessionid
>25.08.11 22:11:03.234  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55463) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:03.234  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55463) pushed request 131430306323474-9 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.287  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:03.287  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:03.287  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306323474-9
>25.08.11 22:11:03.287  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306323474-9
>25.08.11 22:11:03.297  PARSER      ( INFO    ) : UMCP RESPONSE 131430306323474-9 parsed successfully
>25.08.11 22:11:03.297  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306323474-9
>25.08.11 22:11:03.297  MAIN        ( INFO    ) : SessionClient: got response with id=131430306323474-9 and status=200
>25.08.11 22:11:03.297  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55463) got response 131430306323474-9 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.346  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55464) got new request
>25.08.11 22:11:03.346  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55464) found sessionid
>25.08.11 22:11:03.346  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55464) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:03.346  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55464) pushed request 131430306334624-10 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.397  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:03.397  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:03.397  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306334624-10
>25.08.11 22:11:03.397  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306334624-10
>25.08.11 22:11:03.398  PARSER      ( INFO    ) : UMCP RESPONSE 131430306334624-10 parsed successfully
>25.08.11 22:11:03.398  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306334624-10
>25.08.11 22:11:03.398  MAIN        ( INFO    ) : SessionClient: got response with id=131430306334624-10 and status=200
>25.08.11 22:11:03.399  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55464) got response 131430306334624-10 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.482  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55465) got new request
>25.08.11 22:11:03.482  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55465) found sessionid
>25.08.11 22:11:03.482  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55465) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:03.482  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55465) pushed request 131430306348279-11 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:03.499  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:03.499  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:03.499  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306348279-11
>25.08.11 22:11:03.499  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306348279-11
>25.08.11 22:11:03.601  PARSER      ( INFO    ) : UMCP RESPONSE 131430306348279-11 parsed successfully
>25.08.11 22:11:03.601  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306348279-11
>25.08.11 22:11:03.601  MAIN        ( INFO    ) : SessionClient: got response with id=131430306348279-11 and status=200
>25.08.11 22:11:03.601  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55465) got response 131430306348279-11 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.214  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55467) got new request
>25.08.11 22:11:06.214  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55467) found sessionid
>25.08.11 22:11:06.214  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55467) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.214  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55467) pushed request 131430306621451-12 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.215  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55466) got new request
>25.08.11 22:11:06.215  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55466) found sessionid
>25.08.11 22:11:06.215  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55466) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.216  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55466) pushed request 131430306621606-13 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.217  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55468) got new request
>25.08.11 22:11:06.217  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55468) found sessionid
>25.08.11 22:11:06.217  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55468) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.217  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55468) pushed request 131430306621785-14 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.307  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.307  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.307  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306621451-12
>25.08.11 22:11:06.307  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306621451-12
>25.08.11 22:11:06.307  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.307  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.307  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306621606-13
>25.08.11 22:11:06.307  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306621606-13
>25.08.11 22:11:06.307  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.308  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.308  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306621785-14
>25.08.11 22:11:06.308  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306621785-14
>25.08.11 22:11:06.317  PARSER      ( INFO    ) : UMCP RESPONSE 131430306621451-12 parsed successfully
>25.08.11 22:11:06.317  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306621451-12
>25.08.11 22:11:06.317  MAIN        ( INFO    ) : SessionClient: got response with id=131430306621451-12 and status=591
>25.08.11 22:11:06.317  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55467) got response 131430306621451-12 with status 591 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.317  MAIN        ( ERROR   ) : CPCommand (127.0.0.1:55467) response status code: 591
>25.08.11 22:11:06.332  PARSER      ( INFO    ) : The message body is not complete: 16309 of 25921 bytes
>25.08.11 22:11:06.333  PARSER      ( INFO    ) : UMCP RESPONSE 131430306621606-13 parsed successfully
>25.08.11 22:11:06.333  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306621606-13
>25.08.11 22:11:06.333  MAIN        ( INFO    ) : SessionClient: got response with id=131430306621606-13 and status=200
>25.08.11 22:11:06.333  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55466) got response 131430306621606-13 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.348  PARSER      ( INFO    ) : UMCP RESPONSE 131430306621785-14 parsed successfully
>25.08.11 22:11:06.348  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306621785-14
>25.08.11 22:11:06.348  MAIN        ( INFO    ) : SessionClient: got response with id=131430306621785-14 and status=200
>25.08.11 22:11:06.348  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55468) got response 131430306621785-14 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.741  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55469) got new request
>25.08.11 22:11:06.741  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55469) found sessionid
>25.08.11 22:11:06.741  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55469) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.741  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55469) pushed request 131430306674181-15 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.749  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.749  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.749  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306674181-15
>25.08.11 22:11:06.749  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306674181-15
>25.08.11 22:11:06.837  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55470) got new request
>25.08.11 22:11:06.837  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55470) found sessionid
>25.08.11 22:11:06.837  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55470) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.837  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55470) pushed request 131430306683719-16 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.850  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.850  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.850  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306683719-16
>25.08.11 22:11:06.850  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306683719-16
>25.08.11 22:11:06.852  PARSER      ( INFO    ) : UMCP RESPONSE 131430306674181-15 parsed successfully
>25.08.11 22:11:06.852  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306674181-15
>25.08.11 22:11:06.852  MAIN        ( INFO    ) : SessionClient: got response with id=131430306674181-15 and status=200
>25.08.11 22:11:06.852  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55469) got response 131430306674181-15 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.887  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55472) got new request
>25.08.11 22:11:06.887  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55472) found sessionid
>25.08.11 22:11:06.887  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55472) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.887  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55472) pushed request 131430306688752-17 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.887  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55471) got new request
>25.08.11 22:11:06.892  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55473) got new request
>25.08.11 22:11:06.902  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55473) found sessionid
>25.08.11 22:11:06.902  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55473) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.902  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55473) pushed request 131430306690248-18 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.903  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55474) got new request
>25.08.11 22:11:06.903  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55474) found sessionid
>25.08.11 22:11:06.903  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55474) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.903  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55474) pushed request 131430306690387-19 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.905  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55475) got new request
>25.08.11 22:11:06.905  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55475) found sessionid
>25.08.11 22:11:06.905  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55475) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.905  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55475) pushed request 131430306690519-20 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.905  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55471) found sessionid
>25.08.11 22:11:06.905  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55471) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.905  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55471) pushed request 131430306690540-21 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.953  PARSER      ( INFO    ) : UMCP RESPONSE 131430306683719-16 parsed successfully
>25.08.11 22:11:06.953  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306683719-16
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : SessionClient: got response with id=131430306683719-16 and status=200
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306688752-17
>25.08.11 22:11:06.953  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306688752-17
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306690248-18
>25.08.11 22:11:06.953  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306690248-18
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306690387-19
>25.08.11 22:11:06.953  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306690387-19
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306690519-20
>25.08.11 22:11:06.953  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306690519-20
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306690540-21
>25.08.11 22:11:06.953  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306690540-21
>25.08.11 22:11:06.953  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55470) got response 131430306683719-16 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.958  PARSER      ( INFO    ) : UMCP RESPONSE 131430306688752-17 parsed successfully
>25.08.11 22:11:06.958  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306688752-17
>25.08.11 22:11:06.958  MAIN        ( INFO    ) : SessionClient: got response with id=131430306688752-17 and status=200
>25.08.11 22:11:06.960  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55472) got response 131430306688752-17 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.962  PARSER      ( INFO    ) : UMCP RESPONSE 131430306690248-18 parsed successfully
>25.08.11 22:11:06.962  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306690248-18
>25.08.11 22:11:06.962  MAIN        ( INFO    ) : SessionClient: got response with id=131430306690248-18 and status=200
>25.08.11 22:11:06.962  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55473) got response 131430306690248-18 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.968  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55476) got new request
>25.08.11 22:11:06.968  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55476) found sessionid
>25.08.11 22:11:06.968  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55476) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.968  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55476) pushed request 131430306696828-22 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.970  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55477) got new request
>25.08.11 22:11:06.970  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55477) found sessionid
>25.08.11 22:11:06.970  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55477) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.970  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55477) pushed request 131430306697089-23 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:06.972  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55478) got new request
>25.08.11 22:11:06.972  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55478) found sessionid
>25.08.11 22:11:06.972  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55478) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:06.973  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55478) pushed request 131430306697303-24 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.001  PARSER      ( INFO    ) : UMCP RESPONSE 131430306690387-19 parsed successfully
>25.08.11 22:11:07.001  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306690387-19
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : SessionClient: got response with id=131430306690387-19 and status=200
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306696828-22
>25.08.11 22:11:07.001  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306696828-22
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306697089-23
>25.08.11 22:11:07.001  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306697089-23
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.001  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306697303-24
>25.08.11 22:11:07.001  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306697303-24
>25.08.11 22:11:07.002  PARSER      ( INFO    ) : UMCP RESPONSE 131430306690540-21 parsed successfully
>25.08.11 22:11:07.002  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306690540-21
>25.08.11 22:11:07.002  MAIN        ( INFO    ) : SessionClient: got response with id=131430306690540-21 and status=200
>25.08.11 22:11:07.006  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55474) got response 131430306690387-19 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.007  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55471) got response 131430306690540-21 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.009  PARSER      ( INFO    ) : UMCP RESPONSE 131430306690519-20 parsed successfully
>25.08.11 22:11:07.009  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306690519-20
>25.08.11 22:11:07.009  MAIN        ( INFO    ) : SessionClient: got response with id=131430306690519-20 and status=200
>25.08.11 22:11:07.009  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55475) got response 131430306690519-20 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.012  PARSER      ( INFO    ) : UMCP RESPONSE 131430306697089-23 parsed successfully
>25.08.11 22:11:07.012  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306697089-23
>25.08.11 22:11:07.012  MAIN        ( INFO    ) : SessionClient: got response with id=131430306697089-23 and status=200
>25.08.11 22:11:07.012  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55477) got response 131430306697089-23 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.019  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55479) got new request
>25.08.11 22:11:07.019  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55479) found sessionid
>25.08.11 22:11:07.019  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55479) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.019  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55479) pushed request 131430306701938-25 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.021  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55480) got new request
>25.08.11 22:11:07.021  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55480) found sessionid
>25.08.11 22:11:07.021  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55480) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.021  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55480) pushed request 131430306702129-26 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.022  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55481) got new request
>25.08.11 22:11:07.022  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55481) found sessionid
>25.08.11 22:11:07.022  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55481) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.022  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55481) pushed request 131430306702284-27 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.049  PARSER      ( INFO    ) : UMCP RESPONSE 131430306697303-24 parsed successfully
>25.08.11 22:11:07.049  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306697303-24
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : SessionClient: got response with id=131430306697303-24 and status=200
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306701938-25
>25.08.11 22:11:07.049  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306701938-25
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306702129-26
>25.08.11 22:11:07.049  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306702129-26
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.049  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306702284-27
>25.08.11 22:11:07.049  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306702284-27
>25.08.11 22:11:07.050  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55478) got response 131430306697303-24 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.056  PARSER      ( INFO    ) : UMCP RESPONSE 131430306696828-22 parsed successfully
>25.08.11 22:11:07.056  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306696828-22
>25.08.11 22:11:07.056  MAIN        ( INFO    ) : SessionClient: got response with id=131430306696828-22 and status=200
>25.08.11 22:11:07.056  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55476) got response 131430306696828-22 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.059  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55482) got new request
>25.08.11 22:11:07.059  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55482) found sessionid
>25.08.11 22:11:07.059  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55482) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.060  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55482) pushed request 131430306706004-28 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.062  PARSER      ( INFO    ) : UMCP RESPONSE 131430306702129-26 parsed successfully
>25.08.11 22:11:07.062  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306702129-26
>25.08.11 22:11:07.062  MAIN        ( INFO    ) : SessionClient: got response with id=131430306702129-26 and status=200
>25.08.11 22:11:07.062  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55480) got response 131430306702129-26 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.063  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.063  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.063  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306706004-28
>25.08.11 22:11:07.063  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306706004-28
>25.08.11 22:11:07.065  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55483) got new request
>25.08.11 22:11:07.065  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55483) found sessionid
>25.08.11 22:11:07.065  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55483) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.065  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55483) pushed request 131430306706539-29 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.065  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.065  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.065  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306706539-29
>25.08.11 22:11:07.065  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306706539-29
>25.08.11 22:11:07.068  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55484) got new request
>25.08.11 22:11:07.068  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55484) found sessionid
>25.08.11 22:11:07.068  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55484) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.068  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55484) pushed request 131430306706812-30 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.068  PARSER      ( INFO    ) : The message body is not complete: 16309 of 17253 bytes
>25.08.11 22:11:07.068  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.068  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.068  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306706812-30
>25.08.11 22:11:07.068  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306706812-30
>25.08.11 22:11:07.070  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55485) got new request
>25.08.11 22:11:07.070  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55485) found sessionid
>25.08.11 22:11:07.070  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55485) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.071  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55485) pushed request 131430306707092-31 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.106  PARSER      ( INFO    ) : UMCP RESPONSE 131430306702284-27 parsed successfully
>25.08.11 22:11:07.106  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306702284-27
>25.08.11 22:11:07.106  MAIN        ( INFO    ) : SessionClient: got response with id=131430306702284-27 and status=200
>25.08.11 22:11:07.108  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55481) got response 131430306702284-27 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.111  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.111  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.111  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306707092-31
>25.08.11 22:11:07.111  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306707092-31
>25.08.11 22:11:07.111  PARSER      ( INFO    ) : UMCP RESPONSE 131430306706539-29 parsed successfully
>25.08.11 22:11:07.111  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306706539-29
>25.08.11 22:11:07.111  MAIN        ( INFO    ) : SessionClient: got response with id=131430306706539-29 and status=200
>25.08.11 22:11:07.112  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55483) got response 131430306706539-29 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.114  PARSER      ( INFO    ) : UMCP RESPONSE 131430306706812-30 parsed successfully
>25.08.11 22:11:07.114  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306706812-30
>25.08.11 22:11:07.114  MAIN        ( INFO    ) : SessionClient: got response with id=131430306706812-30 and status=200
>25.08.11 22:11:07.114  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55484) got response 131430306706812-30 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.115  PARSER      ( INFO    ) : UMCP RESPONSE 131430306701938-25 parsed successfully
>25.08.11 22:11:07.115  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306701938-25
>25.08.11 22:11:07.115  MAIN        ( INFO    ) : SessionClient: got response with id=131430306701938-25 and status=200
>25.08.11 22:11:07.115  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55479) got response 131430306701938-25 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.116  PARSER      ( INFO    ) : UMCP RESPONSE 131430306706004-28 parsed successfully
>25.08.11 22:11:07.116  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306706004-28
>25.08.11 22:11:07.116  MAIN        ( INFO    ) : SessionClient: got response with id=131430306706004-28 and status=200
>25.08.11 22:11:07.116  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55482) got response 131430306706004-28 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.121  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55486) got new request
>25.08.11 22:11:07.121  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55486) found sessionid
>25.08.11 22:11:07.121  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55486) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.121  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55486) pushed request 131430306712136-32 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.213  PARSER      ( INFO    ) : UMCP RESPONSE 131430306707092-31 parsed successfully
>25.08.11 22:11:07.213  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306707092-31
>25.08.11 22:11:07.213  MAIN        ( INFO    ) : SessionClient: got response with id=131430306707092-31 and status=200
>25.08.11 22:11:07.213  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.213  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.213  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306712136-32
>25.08.11 22:11:07.213  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306712136-32
>25.08.11 22:11:07.213  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55485) got response 131430306707092-31 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.316  PARSER      ( INFO    ) : UMCP RESPONSE 131430306712136-32 parsed successfully
>25.08.11 22:11:07.316  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306712136-32
>25.08.11 22:11:07.316  MAIN        ( INFO    ) : SessionClient: got response with id=131430306712136-32 and status=200
>25.08.11 22:11:07.316  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55486) got response 131430306712136-32 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.363  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55487) got new request
>25.08.11 22:11:07.363  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55487) found sessionid
>25.08.11 22:11:07.363  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55487) sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a"
>25.08.11 22:11:07.363  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55487) pushed request 131430306736323-33 to queue - waiting for response (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")
>25.08.11 22:11:07.416  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: new object in queue
>25.08.11 22:11:07.416  MAIN        ( INFO    ) : UMCP_Dispatcher: check_queue: normal request
>25.08.11 22:11:07.416  MAIN        ( INFO    ) : SessionClient: sending request with id=131430306736323-33
>25.08.11 22:11:07.416  PROTOCOL    ( INFO    ) : Sending UMCP COMMAND REQUEST 131430306736323-33
>25.08.11 22:11:07.519  PARSER      ( INFO    ) : UMCP RESPONSE 131430306736323-33 parsed successfully
>25.08.11 22:11:07.519  PROTOCOL    ( INFO    ) : Received UMCP RESPONSE 131430306736323-33
>25.08.11 22:11:07.519  MAIN        ( INFO    ) : SessionClient: got response with id=131430306736323-33 and status=200
>25.08.11 22:11:07.519  MAIN        ( INFO    ) : CPCommand (127.0.0.1:55487) got response 131430306736323-33 with status 200 (sessionid="006d71f1-6406-4b80-a39f-30f80dd71d1a")

Actions: View

Attachments on bug 23430: 3478 | 3479 | 3480 | 3481