Hi Alex, This has been discussed in numerous ocasions, here's one link to archives: http://onlinestudylist.com/archives/ccie_voice/2010-April/015608.html
Regards, On Fri, Jun 17, 2011 at 10:07 AM, Alex Goh <ncsalex....@gmail.com> wrote: > Hi Guys, > > Anyone encounter this issue before, after voiceview was configured on the > CUE and service subscribed to the IP Phone. I've able to login and see > number of message. > but when I tried to play the message or send a message, I always get > "Authentication error. Report this error to your system administrator". My > CUE is integrate with CUCM and verified correct license file was installed. > > It seems like something to do with the Authentication URL in the service, > anyone can shed some light on this? > > trying to do some trace on CUE and this is what I've got > > > 4519 06/17 17:00:15.815 vovw cont 0 Enter Controller Requested URI: > /voiceview/common/login.do > 4519 06/17 17:00:15.815 vovw sydb 0 /sw/apps/vui/vvconfig/enabled > 4519 06/17 17:00:15.816 vovw sydb 0 1 > 4519 06/17 17:00:15.816 vovw cont 0 Host : 142.1.66.253 > 4519 06/17 17:00:15.817 vovw cont 0 Connection : close > 4519 06/17 17:00:15.817 vovw cont 0 User-Agent : > Allegro-Software-WebClient/4.34 > 4519 06/17 17:00:15.817 vovw cont 0 Accept : x-CiscoIPPhone/*, > text/*,image/png,*/* > 4519 06/17 17:00:15.817 vovw cont 0 Accept-Language : en_US > 4519 06/17 17:00:15.817 vovw cont 0 Accept-Charset : utf-8,iso-8859-1;q=0.8 > 4519 06/17 17:00:15.818 vovw cont 0 x-CiscoIPPhoneModelName : CP-7961G > 4519 06/17 17:00:15.818 vovw cont 0 x-CiscoIPPhoneSDKVersion : 7.0.1 > 4519 06/17 17:00:15.818 vovw cont 0 x-CiscoIPPhoneDisplay : 298,144,3,G > 4519 06/17 17:00:15.818 vovw sydb 0 > /sw/apps/platformCapabilities/system/preferred_language > 4519 06/17 17:00:15.819 vovw sydb 0 en_US > 4519 06/17 17:00:15.819 vovw cont 0 Setting session locale en_US > 4519 06/17 17:00:15.819 vovw sydb 0 /sw/apps/monitor/ctrl/offline > 4519 06/17 17:00:15.820 vovw sydb 0 0 > 4519 06/17 17:00:15.820 vovw cont 0 Center Controller Requested URI: > /voiceview/common/login.do > 4519 06/17 17:00:15.821 vovw sess 0 request > 4519 06/17 17:00:15.821 vovw sess 0 Querying the phone for its device > information. > 4519 06/17 17:00:15.953 vovw sess 0 Phone Model : CP-7961G > 4519 06/17 17:00:15.953 vovw sess 0 Phone MAC Address: 001E138C3CFC > 4519 06/17 17:00:15.953 vovw sess 0 Phone Primary DN : 4001 > 4519 06/17 17:00:15.953 vovw sess 0 Checking if PIN less login is > configured for 4001 > 4519 06/17 17:00:15.985 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4519 06/17 17:00:15.985 VMSS vmdb 0 Got connection: 0, inUse: 1, active: 2 > 4519 06/17 17:00:15.985 VMSS vmdb 7 select mailboxid from vm_mbxusers where > owner=true and userdn='/sw/local/users/scph1'; > 4519 06/17 17:00:15.989 VMSS vmdb 3 PERSONAL_00000000000000000000000 > 4519 06/17 17:00:15.989 VMSS vmdb 0 Freed connection: 0, inUse: 0, active: > 2 > 4519 06/17 17:00:15.990 vovw sess 0 Found mailbox > 4519 06/17 17:00:15.990 vovw sess 0 PIN-less login: 0 > 4519 06/17 17:00:15.990 vovw sess 0 checkPinLess false > 4519 06/17 17:00:15.994 vovw cont 0 Exit Controller Requested URI: > /voiceview/WEB-INF/screens/phoneobjects/CiscoIPPhoneInput.jsp > 4513 06/17 17:00:24.520 vovw cont 0 Enter Controller Requested URI: > /voiceview/common/login.do > 4513 06/17 17:00:24.520 vovw sydb 0 /sw/apps/vui/vvconfig/enabled > 4513 06/17 17:00:24.521 vovw sydb 0 1 > 4513 06/17 17:00:24.522 vovw cont 0 Submit Type 'LOGIN' > 4513 06/17 17:00:24.522 vovw sydb 0 /sw/apps/monitor/ctrl/offline > 4513 06/17 17:00:24.523 vovw sydb 0 0 > 4513 06/17 17:00:24.523 vovw cont 0 Center Controller Requested URI: > /voiceview/common/login.do > 4513 06/17 17:00:24.524 vovw sess 0 LOGIN request > 4513 06/17 17:00:24.539 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4513 06/17 17:00:24.539 VMSS vmdb 0 Got connection: 1, inUse: 1, active: 2 > 4513 06/17 17:00:24.539 VMSS vmdb 7 select mailboxid from vm_mbxusers where > owner=true and userdn='/sw/local/users/scph1'; > 4513 06/17 17:00:24.544 VMSS vmdb 3 PERSONAL_00000000000000000000000 > 4513 06/17 17:00:24.544 VMSS vmdb 0 Freed connection: 1, inUse: 0, active: > 2 > 4513 06/17 17:00:24.545 vovw sess 0 4001 > 4513 06/17 17:00:24.545 vovw sess 0 Found mailbox > 4513 06/17 17:00:24.545 vovw sess 0 Valid extension > 4513 06/17 17:00:24.545 vovw sess 0 Authenticating user > 4513 06/17 17:00:24.545 vovw sess 0 SessionProperties doLogoutCleanup for > 4001 PERSONAL_00000000000000000000000 > 4513 06/17 17:00:24.552 vovw sess 0 Personal mailbox locked. Logging him > out first > 4513 06/17 17:00:24.552 VMSS vmbx 0x000001309cd1135a 9 > /sw/local/users/scph1 > 4513 06/17 17:00:24.553 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4513 06/17 17:00:24.553 VMSS vmdb 0 Got connection: 0, inUse: 1, active: 2 > 4513 06/17 17:00:24.553 VMSS vmdb 7 select vm_message.messageid, > vm_message.uid, recent from vm_message, vm_usermsg where state=3 and > mailboxid='PERSONAL_00000000000000000000000' and > vm_message.messageid=vm_usermsg.messageid; > 4513 06/17 17:00:24.561 VMSS vmdb 0 Freed connection: 0, inUse: 0, active: > 2 > 4513 06/17 17:00:24.563 vovw sess 0 SessionProperties logged out 4001 > session: 34o4vxpr71 > 4513 06/17 17:00:24.563 vovw sess 0 SessionProperties number of users now: > 0 > 4513 06/17 17:00:24.563 vovw sess 0 Checking if PIN less login is > configured for 4001 > 4513 06/17 17:00:24.581 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4513 06/17 17:00:24.581 VMSS vmdb 0 Got connection: 1, inUse: 1, active: 2 > 4513 06/17 17:00:24.581 VMSS vmdb 7 select mailboxid from vm_mbxusers where > owner=true and userdn='/sw/local/users/scph1'; > 4513 06/17 17:00:24.586 VMSS vmdb 3 PERSONAL_00000000000000000000000 > 4513 06/17 17:00:24.586 VMSS vmdb 0 Freed connection: 1, inUse: 0, active: > 2 > 4513 06/17 17:00:24.587 vovw sess 0 Found mailbox > 4513 06/17 17:00:24.587 vovw sess 0 PIN-less login: 0 > 4513 06/17 17:00:24.587 vovw sess 0 checkPinLess false > 4513 06/17 17:00:24.635 vovw sess 0 Opening mailbox > 4513 06/17 17:00:24.635 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4513 06/17 17:00:24.635 VMSS vmdb 0 Got connection: 0, inUse: 1, active: 2 > 4513 06/17 17:00:24.635 VMSS vmdb 7 select * from vm_mailbox where > mailboxid='PERSONAL_00000000000000000000000'; > 4513 06/17 17:00:24.641 VMSS vmdb 3 > PERSONAL_00000000000000000000000,0,null,1694,0,f,2687,30,t,10,0,1308301005582,null,21804790,t,0 > 4513 06/17 17:00:24.641 VMSS vmdb 7 select userdn from vm_mbxusers where > owner=true and mailboxid='PERSONAL_00000000000000000000000'; > 4513 06/17 17:00:24.645 VMSS vmdb 0 Freed connection: 0, inUse: 0, active: > 2 > 4513 06/17 17:00:24.645 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4513 06/17 17:00:24.645 VMSS vmdb 0 Got connection: 1, inUse: 1, active: 2 > 4513 06/17 17:00:24.645 VMSS vmdb 7 select mailboxid from vm_mbxusers where > owner=true and userdn='/sw/local/users/scph1'; > 4513 06/17 17:00:24.649 VMSS vmdb 3 PERSONAL_00000000000000000000000 > 4513 06/17 17:00:24.650 VMSS vmdb 7 select distinct vm_mbxusers.mailboxid, > orphanedtime from vm_mbxusers, vm_mailbox where > vm_mailbox.mailboxid=vm_mbxusers.mailboxid and > (userdn='/sw/local/users/scph1') and orphanedtime=0 and owner=false; > 4513 06/17 17:00:24.656 VMSS vmdb 0 Freed connection: 1, inUse: 0, active: > 2 > 4513 06/17 17:00:24.656 VMSS vmbx 8 /sw/local/users/scph1 > 4513 06/17 17:00:24.657 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4513 06/17 17:00:24.657 VMSS vmdb 0 Got connection: 0, inUse: 1, active: 2 > 4513 06/17 17:00:24.657 VMSS vmdb 7 update vm_mailbox set > lastaccessed=1308301224657 where > mailboxid='PERSONAL_00000000000000000000000'; > 4513 06/17 17:00:24.664 VMSS vmdb 1 > 4513 06/17 17:00:24.736 VMSS vmdb 0 Freed connection: 0, inUse: 0, active: > 2 > 4513 06/17 17:00:24.736 vovw sess 0 Open mailbox successful > 4513 06/17 17:00:24.736 vovw sess 0 SessionProperties logged in user 4001 > session: hjou17pu71 from 142.102.66.10 > 4513 06/17 17:00:24.736 vovw sess 0 Session Info provider attaching... > 4513 06/17 17:00:24.740 vovw sess 0 Session Info provider attached > 4513 06/17 17:00:24.740 vovw sess 0 SessionProperties number of users now: > 1 > 4513 06/17 17:00:24.740 vovw sydb 0 /sw/limits/global/applicationMode > 4513 06/17 17:00:24.741 vovw sydb 0 CCM > 4513 06/17 17:00:24.741 vovw sydb 0 > /sw/apps/wf/ccnapps/configurations/craAesop/ccnwfapp/wfjtapi/ciscoccnatusername > 2769 06/17 17:00:24.742 WFSP JTAP 0 WFSysdbNdJtapi::get enter > 2769 06/17 17:00:24.742 WFSP JTAP 0 WFSysdbNdJtapi::get > attribute=ciscoccnatusername > 2769 06/17 17:00:24.742 WFSP JTAP 0 WFSysdbNdJtapi::get exit > 4513 06/17 17:00:24.742 vovw sydb 0 cuejtapi > 4513 06/17 17:00:24.742 vovw sydb 0 > /sw/apps/wf/ccnapps/configurations/craAesop/ccnwfapp/wfjtapi/ciscoccnatpassword > 2725 06/17 17:00:24.743 WFSP JTAP 0 WFSysdbNdJtapi::get enter > 2725 06/17 17:00:24.743 WFSP JTAP 0 WFSysdbNdJtapi::get > attribute=ciscoccnatpassword > 2725 06/17 17:00:24.744 WFSP JTAP 0 WFSysdbNdJtapi::get exit > 4513 06/17 17:00:24.744 vovw sydb 0 ********** > 4513 06/17 17:00:24.744 vovw sess 0 Forward to home page > 4513 06/17 17:00:24.745 vovw cont 0 Enter Controller Requested URI: > /voiceview/voicemail/home.do > 4513 06/17 17:00:24.745 vovw sydb 0 /sw/apps/vui/vvconfig/enabled > 4513 06/17 17:00:24.746 vovw sydb 0 1 > 4513 06/17 17:00:24.746 vovw cont 0 Submit Type 'LOGIN' > 4513 06/17 17:00:24.747 vovw sydb 0 /sw/apps/monitor/ctrl/offline > 4513 06/17 17:00:24.747 vovw sydb 0 0 > 4513 06/17 17:00:24.748 vovw cont 0 Center Controller Requested URI: > /voiceview/voicemail/home.do > 4513 06/17 17:00:24.748 vovw vmal 0 Get message counts for > com.cisco.aesop.voicemail.Mailbox@31e431e4 > 4513 06/17 17:00:24.749 VMSS vmbx 0 getExpired: 0, > expiryTime=2011-07-17T16:26:46+0800 > 4513 06/17 17:00:24.750 vovw vmal 0 Total number of new msgs: 1 > 4513 06/17 17:00:24.750 vovw vmal 0 Total number of new urgent msgs: 0 > 4513 06/17 17:00:24.750 vovw vmal 0 Total number of saved msgs: 0 > 4513 06/17 17:00:24.750 vovw vmal 0 Total number of expired msgs: 0 > 4513 06/17 17:00:24.750 vovw vmal 0 Total number of broadcast msgs: 0 > 4513 06/17 17:00:24.750 vovw vmal 0 Total number of deleted msgs: 0 > 4513 06/17 17:00:24.750 vovw vmal 0 Mailbox Usage: 0.0 > 4513 06/17 17:00:24.751 vovw vmal 0 Show broadcast menu item false > 4513 06/17 17:00:24.757 vovw cont 0 Exit Controller Requested URI: > /voiceview/WEB-INF/screens/phoneobjects/CiscoIPPhoneMenu.jsp > 4513 06/17 17:00:24.757 vovw cont 0 Exit Controller Requested URI: > /voiceview/WEB-INF/screens/phoneobjects/CiscoIPPhoneMenu.jsp > 4519 06/17 17:00:38.664 vovw cont 0 Enter Controller Requested URI: > /voiceview/voicemail/vmList.do > 4519 06/17 17:00:38.664 vovw sydb 0 /sw/apps/vui/vvconfig/enabled > 4519 06/17 17:00:38.666 vovw sydb 0 1 > 4519 06/17 17:00:38.666 vovw cont 0 Submit Type 'RECONFIGURE' > 4519 06/17 17:00:38.666 vovw sydb 0 /sw/apps/monitor/ctrl/offline > 4519 06/17 17:00:38.667 vovw sydb 0 0 > 4519 06/17 17:00:38.667 vovw cont 0 Center Controller Requested URI: > /voiceview/voicemail/vmList.do > 4519 06/17 17:00:38.668 vovw vmal 0 Attempting to read all messages > 4519 06/17 17:00:38.668 VMSS vmsg 0 PERSONAL_00000000000000000000000 > 4519 06/17 17:00:38.668 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4519 06/17 17:00:38.668 VMSS vmdb 0 Got connection: 1, inUse: 1, active: 2 > 4519 06/17 17:00:38.668 VMSS vmdb 0 Request connection: inUse: 1, active: 2 > 4519 06/17 17:00:38.668 VMSS vmdb 0 Got connection: 0, inUse: 2, active: 2 > 4519 06/17 17:00:38.668 VMSS vmdb 7 select vm_message.*, > vm_usermsg.mailboxid, vm_usermsg.storetime, vm_usermsg.state from > vm_usermsg, vm_message where vm_usermsg.messageid=vm_message.messageid and ( > state=1 or state=2 or state=3) and > mailboxid='PERSONAL_00000000000000000000000' and messagetype<=50 order by > urgent desc, messagetime asc limit 150; > 4519 06/17 17:00:38.677 VMSS vmsg 1 > FHK1250F1MH-AIM-FOC12032LYD-1308299025321 > 4519 06/17 17:00:38.679 VMSS vmdb 3 > FHK1250F1MH-AIM-FOC12032LYD-1308299025321,1,1,/sw/local/users/scph1,f,f,2687,21498,1308299206475,null,17579,17-Jun-11 > 08:26:46 > UTC,9223372036854775807,1308299206475,0,0,t,2687,1,,PERSONAL_00000000000000000000000,1308299206475,1 > 4519 06/17 17:00:38.679 VMSS vmsg 0 Message Properties msgId > FHK1250F1MH-AIM-FOC12032LYD-1308299025321 msgUID 1 > 4519 06/17 17:00:38.679 VMSS vmdb 0 Freed connection: 0, inUse: 1, active: > 2 > 4519 06/17 17:00:38.679 VMSS vmdb 0 Freed connection: 1, inUse: 0, active: > 2 > 4519 06/17 17:00:38.679 vovw vmal 0 1 messages > 4519 06/17 17:00:38.695 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4519 06/17 17:00:38.695 VMSS vmdb 0 Got connection: 0, inUse: 1, active: 2 > 4519 06/17 17:00:38.695 VMSS vmdb 7 select mailboxid from vm_mbxusers where > owner=true and userdn='/sw/local/users/scph1'; > 4519 06/17 17:00:38.700 VMSS vmdb 3 PERSONAL_00000000000000000000000 > 4519 06/17 17:00:38.700 VMSS vmdb 0 Freed connection: 0, inUse: 0, active: > 2 > 4519 06/17 17:00:38.700 vovw vmal 0 Message ID: > FHK1250F1MH-AIM-FOC12032LYD-1308299025321 Sender: /sw/local/users/scph1 > 4519 06/17 17:00:38.700 vovw vmal 0 Type: 1 > 4519 06/17 17:00:38.700 vovw vmal 0 Status: 1 > 4519 06/17 17:00:38.700 vovw vmal 0 The location of the sender: null > 4519 06/17 17:00:38.700 vovw vmal 0 The location initials of the sender: > 4519 06/17 17:00:38.700 vovw vmal 0 The phone number of the sender: 4001 > 4519 06/17 17:00:38.700 vovw vmal 0 Extension: 4001 > 4519 06/17 17:00:38.700 vovw vmal 0 senderstr: /sw/local/users/scph1 > 4519 06/17 17:00:38.701 vovw vmal 0 address.getUser().getUserId(): scph1 > 4519 06/17 17:00:38.701 vovw sydb 0 /sw/local/users/scph1/Name/givenName > 4519 06/17 17:00:38.701 vovw sydb 0 > 4519 06/17 17:00:38.701 vovw sydb 0 /sw/local/users/scph1/Name/surname > 4519 06/17 17:00:38.702 vovw sydb 0 scph > 4519 06/17 17:00:38.703 vovw vmal 0 Date: Today 4:26 PM > 4519 06/17 17:00:38.703 vovw vmal 0 filterVoiceMails > 4519 06/17 17:00:38.703 vovw vmal 0 sortAndNumberMails > 4519 06/17 17:00:38.703 vovw vmal 0 clipMails > 4519 06/17 17:00:38.736 vovw cont 0 Exit Controller Requested URI: > /voiceview/WEB-INF/screens/phoneobjects/CiscoIPPhoneIconMenu.jsp > 4513 06/17 17:00:44.427 vovw cont 0 Enter Controller Requested URI: > /voiceview/voicemail/playvm.do > 4513 06/17 17:00:44.427 vovw sydb 0 /sw/apps/vui/vvconfig/enabled > 4513 06/17 17:00:44.428 vovw sydb 0 1 > 4513 06/17 17:00:44.429 vovw cont 0 Submit Type 'RECONFIGURE' > 4513 06/17 17:00:44.429 vovw sydb 0 /sw/apps/monitor/ctrl/offline > 4513 06/17 17:00:44.430 vovw sydb 0 0 > 4513 06/17 17:00:44.430 vovw cont 0 Center Controller Requested URI: > /voiceview/voicemail/playvm.do > 4513 06/17 17:00:44.437 vovw vcmt 0 RECONFIGURE request > FHK1250F1MH-AIM-FOC12032LYD-1308299025321 > 4513 06/17 17:00:44.453 VMSS vmdb 0 Request connection: inUse: 0, active: 2 > 4513 06/17 17:00:44.453 VMSS vmdb 0 Got connection: 1, inUse: 1, active: 2 > 4513 06/17 17:00:44.453 VMSS vmdb 7 select mailboxid from vm_mbxusers where > owner=true and userdn='/sw/local/users/scph1'; > 4513 06/17 17:00:44.458 VMSS vmdb 3 PERSONAL_00000000000000000000000 > 4513 06/17 17:00:44.459 VMSS vmdb 0 Freed connection: 1, inUse: 0, active: > 2 > 4513 06/17 17:00:44.466 vovw cont 0 Exit Controller Requested URI: > /voiceview/WEB-INF/screens/phoneobjects/CiscoIPPhoneText.jsp > 4519 06/17 17:00:52.840 vovw cont 0 Enter Controller Requested URI: > /voiceview/voicemail/playvm.do > 4519 06/17 17:00:52.840 vovw sydb 0 /sw/apps/vui/vvconfig/enabled > 4519 06/17 17:00:52.842 vovw sydb 0 1 > 4519 06/17 17:00:52.842 vovw cont 0 Submit Type 'LISTEN' > 4519 06/17 17:00:52.842 vovw sydb 0 /sw/apps/monitor/ctrl/offline > 4519 06/17 17:00:52.843 vovw sydb 0 0 > 4519 06/17 17:00:52.843 vovw cont 0 Center Controller Requested URI: > /voiceview/voicemail/playvm.do > 4519 06/17 17:00:52.845 vovw vcmt 0 Adding OID: 17579 > 4519 06/17 17:00:52.845 vovw vcmt 0 Total play time 3 > 4519 06/17 17:00:52.845 vovw vcmt 0 SoundTransmitter started > 6216 06/17 17:00:52.847 VCCN svve 0 requestNewSession: enter > 6216 06/17 17:00:52.847 ACCN COMG 0 ContactStubImpl is constructed, > id=6,type=Cisco VoiceView Call,impl id=null > 6216 06/17 17:00:52.847 VCCN svve 0 New contact created id: 6 > 6216 06/17 17:00:52.847 VCCN svve 0 Number of active contacts: 1 > 4519 06/17 17:00:52.849 vovw vcmt 0 New CRA callId: 6 > 6216 06/17 17:00:52.858 ACCN CHMG 0 ChMgrImpl:getGroup - got following > group > GroupStub[channelClass=com.cisco.wf.subsystems.cmt.CMTDialogChannelImpl,type=Cisco > Media Channel,id=0,name=0,state=IN_SERVICE,channel=6] > 6216 06/17 17:00:52.858 ACCN CHMG 0 GroupStubImpl::findAndLockIdleChannel() > - inside > method-GroupStub[channelClass=com.cisco.wf.subsystems.cmt.CMTDialogChannelImpl,type=Cisco > Media Channel,id=0,name=0,state=IN_SERVICE,channel=6] > 6216 06/17 17:00:52.858 ACCN CHMG 0 ChStubImpl:getChannelLock() -id=1 > trying to get channel lock ... > 6216 06/17 17:00:52.859 ACCN CHMG 0 ChStubImpl:getChannelLock() - channel > locked > successfully-ChannelStub[channelClass=com.cisco.dialog.DialogChannel,type=Cisco > Media Channel,id=1,state=IDLE,pendingState=null,groupId=0,locked=true] > 6216 06/17 17:00:52.859 ACCN CHMG 0 GroupStubImpl::findAndLockIdleChannel() > - channel successfully > lockedChannelStub[channelClass=com.cisco.dialog.DialogChannel,type=Cisco > Media Channel,id=1,state=IDLE,pendingState=null,groupId=0,locked=true] > 6216 06/17 17:00:52.859 ACCN COMG 0 getApplicationPrivilege(): application > is null for contact: 6 > 6216 06/17 17:00:52.859 ACCN COMG 0 ContactManager: Acquiring a port of > type: AAWorkflowPrivilege > 6216 06/17 17:00:52.859 LLMA LAPI 0 Llama: vmPortAllocate(): Allocating vm > port for requestor "CRS" > 6216 06/17 17:00:52.861 LLMA LSDB 0 Llama: vmPortAllocate(): > LlamaSysdbUser(): setString(): Setting > /sw/apps/limitsManager/vmPort/allocate/requestor to CRS > 2730 06/17 17:00:52.862 LLMA LSDB 0 LlamaVmPortAllocate: check(): > requestor, Value: CRS: returns true > 2769 06/17 17:00:52.863 LLMA LVMP 0 LlamaVmPortAllocate: commit(): > Attribute: requestor, Value: CRS > 2769 06/17 17:00:52.863 LLMA LLIC 0 LlamaLicense incrementCount VM Port > Feature - countsUsed = 1 > 6216 06/17 17:00:52.864 LLMA LAPI 0 Llama: vmPortAllocate(): Allocate vm > port for requestor "CRS" returns true > 6216 06/17 17:00:52.864 ACCN COMG 0 ContactManager: Port of type > AAWorkflowPrivilege acquired successfully > 6216 06/17 17:00:52.864 ACCN COMG 0 Port of type AAWorkflowPrivilege > acquired for contact #6 > 6216 06/17 17:00:52.865 ACCN CHMG 0 CHANNEL_STATE_CHANGE:Channel has > changed state: Channel=null,Channel > Class=com.cisco.dialog.DialogChannel,Channel Type=Cisco Media > Channel,Channel id=1,Channel implementation id=1,Old state=IDLE,New > state=IN_USE > 6216 06/17 17:00:52.865 ACCN CMTS 0 MediaDialogChannel id=1,state=IN_USE > MDC::init > 6216 06/17 17:00:52.865 ACCN CMTS 0 MediaDialogChannel id=1,state=IN_USE > ::init: create newMediaManagerImpl > 6216 06/17 17:00:52.865 ACCN LMED 0 After allocating sync object > 6216 06/17 17:00:52.866 ACCN LMED 0 Enter RTPRecorder constructor > 6216 06/17 17:00:52.866 ACCN LMED 0 Enter: > DoubleBufferDatagramInputStream:Constructor > 6216 06/17 17:00:52.866 ACCN CHMG 0 GrpStubImpl:notifyChannelStateChange - > state change recvd from: > ChannelStub[channelClass=com.cisco.dialog.DialogChannel,type=Cisco Media > Channel,id=1,state=IN_USE,pendingState=null,groupId=0,locked=false] > 6216 06/17 17:00:52.867 ACCN CHMG 0 GrpStubImpl:notifyChannelStateChange - > channel changed from: IDLE ---> IN_USE > for-GroupStub[channelClass=com.cisco.wf.subsystems.cmt.CMTDialogChannelImpl,type=Cisco > Media Channel,id=0,name=0,state=IN_SERVICE,channel=6] > 6216 06/17 17:00:52.867 ACCN CHMG 0 GrpStubImpl:notifyChannelInUse - No > Group state change - channel state changed from Idle --> InUse > 6216 06/17 17:00:52.867 ACCN CHMG 0 ChStubImpl:handleInUseTransition - > notifying all waiting threads that channel is no longer > idle-ChannelStub[channelClass=com.cisco.dialog.DialogChannel,type=Cisco > Media Channel,id=1,state=IN_USE,pendingState=null,groupId=0,locked=false] > 6216 06/17 17:00:52.867 VCCN svve 0 Contact: 6 New dialog channel obtained: > 1 > 6216 06/17 17:00:52.867 VCCN svve 0 Contact: 6 initPlay(): done > 6216 06/17 17:00:53.148 VCCN svve 0 Number of active contacts: 0 > 6216 06/17 17:00:53.148 VCCN svve 0 VVEContact: terminate(): 6 > 6216 06/17 17:00:53.149 ACCN CHMG 0 ChStubImpl:handleIdleTransition - > channel currently InUse - removing channel from > contact-ChannelStub[channelClass=com.cisco.dialog.DialogChannel,type=Cisco > Media Channel,id=1,state=IN_USE,pendingState=null,groupId=0,locked=false] > 6216 06/17 17:00:53.149 ACCN CMTS 0 MediaDialogChannel id=1,state=IN_USE > MDC::abort: return without waiting > 6216 06/17 17:00:53.149 ACCN CMTS 0 MediaDialogChannel id=1,state=IN_USE > MediaManager resetted. > 6216 06/17 17:00:53.149 ACCN LMED 0 PromptPlayer::closeStream > 6216 06/17 17:00:53.149 ACCN LMED 0 PromptPlayer::resetSources > 6216 06/17 17:00:53.149 ACCN LMED 0 PromptPlayer::rtpData close > 6216 06/17 17:00:53.149 ACCN LMED 0 PromptPlayer::closeStream done > 6216 06/17 17:00:53.149 ACCN LMED 0 Enter RTPRecorder:stopRecord > 6216 06/17 17:00:53.149 ACCN LMED 0 closeStream(), port=0 > 6216 06/17 17:00:53.149 ACCN LMED 0 Stopping doublebuffer input stream > 6216 06/17 17:00:53.149 ACCN LMED 0 Enter: > DoubleBufferDatagramInputStream:stop > 6216 06/17 17:00:53.150 ACCN CHMG 0 CHANNEL_STATE_CHANGE:Channel has > changed state: Channel=null,Channel > Class=com.cisco.dialog.DialogChannel,Channel Type=Cisco Media > Channel,Channel id=1,Channel implementation id=1,Old state=IN_USE,New > state=IDLE > 6216 06/17 17:00:53.151 ACCN CHMG 0 GrpStubImpl:notifyChannelStateChange - > state change recvd from: > ChannelStub[channelClass=com.cisco.dialog.DialogChannel,type=Cisco Media > Channel,id=1,state=IDLE,pendingState=null,groupId=0,locked=true] > 6216 06/17 17:00:53.151 ACCN CHMG 0 GrpStubImpl:notifyChannelStateChange - > channel changed from: IN_USE ---> IDLE > for-GroupStub[channelClass=com.cisco.wf.subsystems.cmt.CMTDialogChannelImpl,type=Cisco > Media Channel,id=0,name=0,state=IN_SERVICE,channel=6] > 6216 06/17 17:00:53.151 ACCN CHMG 0 GrpStubImpl:notifyChannelIdle - No > Group state change - channel state changed from InUse --> Idle > 6216 06/17 17:00:53.151 ACCN CHMG 0 GrpStubImpl:notifyChannelIdle - calling > async.release() to make channel available > 6216 06/17 17:00:53.151 ACCN CHMG 0 ChStubImpl:releaseChannelLock() - > channel lock > releasedChannelStub[channelClass=com.cisco.dialog.DialogChannel,type=Cisco > Media Channel,id=1,state=IDLE,pendingState=null,groupId=0,locked=false] > 6216 06/17 17:00:53.151 ACCN COMG 0 getApplicationPrivilege(): application > is null for contact: 6 > 6216 06/17 17:00:53.151 ACCN COMG 0 ContactManager: Releasing a port of > type: AAWorkflowPrivilege > 6216 06/17 17:00:53.151 LLMA LAPI 0 Llama: vmPortDeallocate(): Deallocating > vm port for requestor "CRS" > 6216 06/17 17:00:53.153 LLMA LSDB 0 Llama: vmPortDeallocate(): > LlamaSysdbUser(): setString(): Setting > /sw/apps/limitsManager/vmPort/deallocate/requestor to CRS > 2725 06/17 17:00:53.154 LLMA LSDB 0 LlamaVmPortDeallocate: check(): > requestor, Value: CRS: returns true > 2771 06/17 17:00:53.158 LLMA LVMP 0 LlamaVmPortDeallocate: commit(): > Attribute: requestor, Value: CRS > 2771 06/17 17:00:53.158 LLMA LLIC 0 LlamaLicense decrementCount VM Port > Feature - countsUsed = 0 > 6216 06/17 17:00:53.159 LLMA LAPI 0 Llama: vmPortDeallocate(): Deallocate > vm port for requestor "CRS" returns true > 6216 06/17 17:00:53.159 ACCN COMG 0 ContactManager: Port of type > AAWorkflowPrivilege released successfully > 6216 06/17 17:00:53.160 ACCN COMG 0 IVR port for privilege: > AAWorkflowPrivilege released by contact #6 > 4519 06/17 17:00:53.162 vovw vcmt 0 CiscoIPPhoneError: 4 null > 4519 06/17 17:00:53.165 vovw cont 0 Exit Controller Requested URI: > /voiceview/WEB-INF/screens/phoneobjects/CiscoIPPhoneText.jsp > > Thanks > > Alex > > _______________________________________________ > For more information regarding industry leading CCIE Lab training, please > visit www.ipexpert.com > > Are you a CCNP or CCIE and looking for a job? Check out > www.PlatinumPlacement.com >
_______________________________________________ For more information regarding industry leading CCIE Lab training, please visit www.ipexpert.com Are you a CCNP or CCIE and looking for a job? Check out www.PlatinumPlacement.com
