Voice Portal Management System - Version 5.1.0.0.4201
I keep getting this error and it leaves sessions active. Yesterday it happened about 30 times for 900 calls. eventually all ports remain active. Having to reboot MPPs daily.
Here is an error log entry from VPMS:
1/21/13 1:59:48 PM
ivrmpp02
VP Session Manager Error PSESM00072
Timeout waiting for release of session resources, session ID ivrmpp02-2013021194344-16, resource map [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0]
FileName=Session.cpp LineNumber=5880
and a short clip from MPP SessMgr Log:
@2013-01-21 13:52:35,871||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 227120 ms|ivrmpp02####
@2013-01-21 13:52:35,871||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:53:05,878||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:53:05,878||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 257120 ms|ivrmpp02####
@2013-01-21 13:53:05,878||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:53:35,884||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:53:35,884||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 287120 ms|ivrmpp02####
@2013-01-21 13:53:35,884||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:54:05,891||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:54:05,891||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 317120 ms|ivrmpp02####
@2013-01-21 13:54:05,891||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:54:35,897||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:54:35,897||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 347130 ms|ivrmpp02####
@2013-01-21 13:54:35,897||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:55:05,904||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:55:05,904||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 377130 ms|ivrmpp02####
@2013-01-21 13:55:05,904||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:55:35,910||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:55:35,910||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 407130 ms|ivrmpp02####
@2013-01-21 13:55:35,910||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:56:05,917||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:56:05,917||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 437130 ms|ivrmpp02####
@2013-01-21 13:56:05,917||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:56:35,923||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:56:35,923||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 467130 ms|ivrmpp02####
@2013-01-21 13:56:35,923||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:57:05,930||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:57:05,930||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 497130 ms|ivrmpp02####
@2013-01-21 13:57:05,930||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:57:35,936||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:57:35,937||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 527140 ms|ivrmpp02####
@2013-01-21 13:57:35,937||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:58:05,943||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:58:05,943||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 557140 ms|ivrmpp02####
@2013-01-21 13:58:05,943||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:58:35,949||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:58:35,950||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 587140 ms|ivrmpp02####
@2013-01-21 13:58:35,950||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Run - got message of type SessionMsg|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Run - got message of type SessionMsg : TerminateDialogTimeoutMsg|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||******** Entering Session.cpp:3957:ProcessSessionCtrlMsg|ivrmpp02### #
@2013-01-21 13:58:48,703||FINE|SessMgr|17484||SessionID = ivrmpp02-2013021194344-16, Receive Dialog terminate timeout for dialog 764|ivrmpp02####
@2013-01-21 13:58:48,703||FINE|SessMgr|17484||DialogHandle: 764 for terminate timeout is no longer valid, dialog must already be gone...|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||******** Leaving Session.cpp:3957:ProcessSessionCtrlMsg|ivrmpp02### #
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:58:48,703||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0], wait time = 599890 ms|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:59:18,709||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:59:18,710||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0], wait time = 629890 ms|ivrmpp02####
@2013-01-21 13:59:18,710||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:59:48,716||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0], wait time = 659890 ms|ivrmpp02####
@2013-01-21 13:59:48,716||FINE|SessMgr|17484||Exit conditions have been met (all resource released or session terminate timeout)|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||******** Entering Session.cpp:3615:LogSession|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||******** Leaving Session.cpp:3615:LogSession|ivrmpp02####
@2013-01-21 13:59:48,716|PSESM00072|ERROR|SessMgr|17484|FileNa me=Session.cpp,LineNumber=5880|Timeout waiting for release of session resources, session ID ivrmpp02-2013021194344-16, resource map [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0]|ivrmpp02####
@2013-01-21 13:59:48,716||FINE|SessMgr|17484||CSession::Run() - Exiting Session 1403 - ivrmpp02-2013021194344-16|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||******** Leaving Session.cpp:5136:Run|ivrmpp02####
@2013-01-21 13:59:48,716||FINE|SessMgr|17484||CSessionMgr:
estroySession - Destroying Session[slot 11] 1403 - ivrmpp02-2013021194344-16|ivrmpp02####
@2013-01-21 13:59:48,717||FINER|SessMgr|17484||CSessionMgr:estroySession - Session 1403, ivrmpp02-2013021194344-16 is being removed from SessionMgr control|ivrmpp02####
@2013-01-21 13:59:48,717||FINER|SessMgr|17484||CSessionMgr:estroySession - Current Active Sessions = 6, Current ASR ports = 0, Current TTS ports = 0|ivrmpp02####
@2013-01-21 13:59:48,717||FINE|SessMgr|17484||CSessionMgr:estroySession - Session Destroyed 1403 - ivrmpp02-2013021194344-16|ivrmpp02####
At the end of the IVR application, all calls are blind transferred to internal 5 digit extensions (live agents) and the calls may last quite a while.
Is that what is keeping the Calls from clearing? How should I handle it?
How can I increase the timeout as a temporary fix?
thanks,
bob
I keep getting this error and it leaves sessions active. Yesterday it happened about 30 times for 900 calls. eventually all ports remain active. Having to reboot MPPs daily.
Here is an error log entry from VPMS:
1/21/13 1:59:48 PM
ivrmpp02
VP Session Manager Error PSESM00072
Timeout waiting for release of session resources, session ID ivrmpp02-2013021194344-16, resource map [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0]
FileName=Session.cpp LineNumber=5880
and a short clip from MPP SessMgr Log:
@2013-01-21 13:52:35,871||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 227120 ms|ivrmpp02####
@2013-01-21 13:52:35,871||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:53:05,878||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:53:05,878||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 257120 ms|ivrmpp02####
@2013-01-21 13:53:05,878||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:53:35,884||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:53:35,884||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 287120 ms|ivrmpp02####
@2013-01-21 13:53:35,884||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:54:05,891||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:54:05,891||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 317120 ms|ivrmpp02####
@2013-01-21 13:54:05,891||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:54:35,897||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:54:35,897||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 347130 ms|ivrmpp02####
@2013-01-21 13:54:35,897||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:55:05,904||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:55:05,904||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 377130 ms|ivrmpp02####
@2013-01-21 13:55:05,904||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:55:35,910||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:55:35,910||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 407130 ms|ivrmpp02####
@2013-01-21 13:55:35,910||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:56:05,917||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:56:05,917||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 437130 ms|ivrmpp02####
@2013-01-21 13:56:05,917||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:56:35,923||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:56:35,923||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 467130 ms|ivrmpp02####
@2013-01-21 13:56:35,923||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:57:05,930||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:57:05,930||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 497130 ms|ivrmpp02####
@2013-01-21 13:57:05,930||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:57:35,936||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:57:35,937||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 527140 ms|ivrmpp02####
@2013-01-21 13:57:35,937||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:58:05,943||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:58:05,943||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 557140 ms|ivrmpp02####
@2013-01-21 13:58:05,943||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:58:35,949||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:58:35,950||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 1], wait time = 587140 ms|ivrmpp02####
@2013-01-21 13:58:35,950||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Run - got message of type SessionMsg|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Run - got message of type SessionMsg : TerminateDialogTimeoutMsg|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||******** Entering Session.cpp:3957:ProcessSessionCtrlMsg|ivrmpp02### #
@2013-01-21 13:58:48,703||FINE|SessMgr|17484||SessionID = ivrmpp02-2013021194344-16, Receive Dialog terminate timeout for dialog 764|ivrmpp02####
@2013-01-21 13:58:48,703||FINE|SessMgr|17484||DialogHandle: 764 for terminate timeout is no longer valid, dialog must already be gone...|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||******** Leaving Session.cpp:3957:ProcessSessionCtrlMsg|ivrmpp02### #
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:58:48,703||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0], wait time = 599890 ms|ivrmpp02####
@2013-01-21 13:58:48,703||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:59:18,709||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:59:18,710||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0], wait time = 629890 ms|ivrmpp02####
@2013-01-21 13:59:18,710||FINEST|SessMgr|17484||Run - Waiting for message...|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||Checking for Call disconnects...|ivrmpp02####
@2013-01-21 13:59:48,716||FINER|SessMgr|17484||Check for exit conditions for session: [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0], wait time = 659890 ms|ivrmpp02####
@2013-01-21 13:59:48,716||FINE|SessMgr|17484||Exit conditions have been met (all resource released or session terminate timeout)|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||******** Entering Session.cpp:3615:LogSession|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||******** Leaving Session.cpp:3615:LogSession|ivrmpp02####
@2013-01-21 13:59:48,716|PSESM00072|ERROR|SessMgr|17484|FileNa me=Session.cpp,LineNumber=5880|Timeout waiting for release of session resources, session ID ivrmpp02-2013021194344-16, resource map [Call 1, CCXML 0, VXML 0, Preparing 0, Msg 0]|ivrmpp02####
@2013-01-21 13:59:48,716||FINE|SessMgr|17484||CSession::Run() - Exiting Session 1403 - ivrmpp02-2013021194344-16|ivrmpp02####
@2013-01-21 13:59:48,716||FINEST|SessMgr|17484||******** Leaving Session.cpp:5136:Run|ivrmpp02####
@2013-01-21 13:59:48,716||FINE|SessMgr|17484||CSessionMgr:
estroySession - Destroying Session[slot 11] 1403 - ivrmpp02-2013021194344-16|ivrmpp02####@2013-01-21 13:59:48,717||FINER|SessMgr|17484||CSessionMgr:
estroySession - Session 1403, ivrmpp02-2013021194344-16 is being removed from SessionMgr control|ivrmpp02####@2013-01-21 13:59:48,717||FINER|SessMgr|17484||CSessionMgr:
estroySession - Current Active Sessions = 6, Current ASR ports = 0, Current TTS ports = 0|ivrmpp02####@2013-01-21 13:59:48,717||FINE|SessMgr|17484||CSessionMgr:
estroySession - Session Destroyed 1403 - ivrmpp02-2013021194344-16|ivrmpp02####At the end of the IVR application, all calls are blind transferred to internal 5 digit extensions (live agents) and the calls may last quite a while.
Is that what is keeping the Calls from clearing? How should I handle it?
How can I increase the timeout as a temporary fix?
thanks,
bob
Comment