MOH Failure

Great protocol analysis of MOH / IPVMS failure:

>>>>>>>>>>Call made by the calling phone
04/08/2014 11:30:09.389 CCM|StationInit: (0048958) EnblocCall calledParty=XXX.|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784199155><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::State Transition><MASK::0020>

04/08/2014 11:30:09.391 CCM|StationD:    (0048958) DialedNumber dialedNumber=XXX lineInstance=1 callReference=118970157.|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784199155><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::State Transition><MASK::0020>

>>>>>>>>>> Called party rings
04/08/2014 11:30:09.394 CCM|StationD:    (0008499) DEBUG- saveRinger for: ci=118970158, line=1, mode=2, precedence=5, callPhase=5.|<CLID::StandAloneCluster><NID::10.21.199.36><CT::7,100,39,1.784199155><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::State Transition><MASK::0020>
04/08/2014 11:30:09.394 CCM|StationD:    (0008499) DEBUG- saveRinger: ci=118970158, line=1, mode=2, precedence=5, callPhase=5, modifier=0|<CLID::StandAloneCluster><NID::10.21.199.36><CT::7,100,39,1.784199155><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::State Transition><MASK::0020>

04/08/2014 11:30:09.397 CCM|StationD:    (0008499) (3,100,9,9002) CallInfo callingPartyName=’XXX XXX’ callingParty=XXX cgpnVoiceMailbox=                             alternateCallingParty= XXX                                   calledPartyName=’XXX’ calledParty=XXX cdpnVoiceMailbox=                           originalCalledPartyName=’XXX’ originalCalledParty=XXX originalCdpnVoiceMailbox= originalCdpnRedirectReason=0                                   lastRedirectingPartyName=’XXX XXX’ lastRedirectingParty=6464975 lastRedirectingVoiceMailbox= lastRedirectingReason=0                                 callType=1(InBound) lineInstance=1 callReference=118970158. version: 85720016|<CLID::StandAloneCluster><NID::10.21.199.36><CT::7,100,39,1.784199155><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::State Transition><MASK::0020>

>>>>>>>>>>> Call put on hold
04/08/2014 11:30:20.486 CCM|StationInit: (0048958) SoftKeyEvent softKeyEvent=3(Hold) lineInstance=1 callReference=118970157.|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784200841><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::State Transition><MASK::0020>

>>>>>>>>>>> Allocating MOH device
04/08/2014 11:30:20.490 CCM|MohDControl – MTP is being used, allocating unicast MOH|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784200841><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::Detailed><MASK::4000>

04/08/2014 11:30:20.490 CCM|MohDControl – waiting_AllocateMohResourceReq – Device Name = MOH, Call Identifier = 118970202 MultiCast Flag = 0, AudiSource Id = 1|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784200841><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::Detailed><MASK::4000>

>>>>>>>>>> Audio source ID 1 selected
04/08/2014 11:30:20.491 CCM|MohDControl – handleMohSuccess – Call Id = 118970202 AudioSourceID = 1 MuticastFlag = 0|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784200841><IP::10.18.201.66><DEV::SEPECC882B186B5><LVL::Detailed><MASK::4000>

>>>>>>>>> Start Media Transmission
04/08/2014 11:30:20.505 CCM|MohDControl – stationOutputStartMediaTransmission tcpPID = [7.100.9.29] myIP: 26c7150a (10.21.199.38)|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784200845><IP::10.18.199.3><DEV::3845_01_MTP><LVL::Significant><MASK::4000>

04/08/2014 11:30:20.505 CCM|MohDControl – RemoteIpAddr: 3c7120a (10.18.199.3) RemoteRtpPortNumber: 19554 msecPacketSize: 20 compressionType: 4|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784200845><IP::10.18.199.3><DEV::3845_01_MTP><LVL::Significant><MASK::4000>
0

>>>>>>>>>> Start Media Transmission Ack with error
04/08/2014 11:30:20.506 CCM|MohDControl(MOH) – star_StationStartMediaTransmissionAck – No Agena PID exists for PartyId=119128475, CI=118970202|<CLID::StandAloneCluster><NID::10.18.199.36><CT::7,100,39,1.784200847><IP::10.21.199.38><DEV::MOH><LVL::Error><MASK::4000>

>>>>>>>>>> In The SDL traces for the same time see the following:
1058125479| 2014/04/08 11:30:20.505| 007| SdlSig    | StationStartMediaTransmissionAck      | waiting                       | MohDControl(7,100,97,1)         | StationInit(7,100,39,1)         | (7,100,39,1).784200847-(ONC_MOH:10.21.199.38)| [R:NP – HP: 0, NP: 0, LP: 0, VLP: 0, LZP: 0 DBP: 0]ConfId=1 PartyId=719c19b CallRef=717575a transmitIpAddr=.type=0 .addr=0x{a,15,c7,26,0,0,0,0,0,0,0,0,0,0,0,0} Port=0

Action Plan:
Restart the IPVMS service on the two servers in a maintenance window.

Advertisements

About Amir Safayan

I live with my family in beautiful Colorado. We have a basset / beagle named Cisco. We board / ski, ride dirtbikes, RV and enjoy living in the Western US. I've done R/S, security, wireless, IPT and am now focused on virtualization technologies on the High Touch Team for Shoregroup.com, a large Cisco reseller.
This entry was posted in Uncategorized. Bookmark the permalink.

Leave a Reply

Fill in your details below or click an icon to log in:

WordPress.com Logo

You are commenting using your WordPress.com account. Log Out / Change )

Twitter picture

You are commenting using your Twitter account. Log Out / Change )

Facebook photo

You are commenting using your Facebook account. Log Out / Change )

Google+ photo

You are commenting using your Google+ account. Log Out / Change )

Connecting to %s