Random one way audio 3

[driven0]

Hello, running IPO 500 V2 8.1

Running into problems with random one-way audio. I was able to trace one of the calls as it happened and here is the trace:

I can't figure out why this happens at what seems to be random times. Any help is greatly appreciated.



Line: type=SIPLine 17 Call: lid=17 id=12764 in=1
Called[248XXXXXXX] Type=Default (100) Reason=CMDRdirect SndComp Calling[330XXXXXXX@IP] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Unavailable
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=330XXXXXXX@IP
IE CMIEFastStartInfoData (6) 4 item(s)
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Unavailable
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=12764 ipaddr=172.16.10.2 apps=8
2837139743mS CD: CALL: 17.12764.1 BState=Idle Cut=1 Music=0.0 Aend="Line 17" (0.0) Bend="" [] (0.0) CalledNum=248XXXXXXX () CallingNum=330XXXXXXX@IP (Unavailable) Internal=0 Time=4 AState=Idle
2837139744mS CMCallEvt: 17.12764.1 2376 SIPTrunk Endpoint: StateChange: END=A CMCSIdle->CMCSDialInitiated
2837139744mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: LOOKUP CALL ROUTE: type=100 called_party=248XXXXXXX sub= calling=330XXXXXXX@IP dir=in complete=1 ses=0
2837139744mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: SET BESTMATCH: length 10 vs -1 match=248XXXXXXX dest=VM:AutoAtt1
2837139744mS CMCallEvt: Priority hike: call 2376 priority 0->1
2837139744mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: LOOKUP ICR: DDI=248XXXXXXX CGPN=330XXXXXXX@IP (Destination VM:AutoAtt1 ) => CDPN=VM:AutoAtt1
2837139745mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: ADD TARGET (N): number=VM:AutoAtt1 type=100 depth=1 nobar=1 setorig=1 ses=0
2837139745mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: ADD VM TARGET
2837139745mS CMTARGET: **** 17.12764.1 2376 SIPTrunk Endpoint: MakeVoicemailTarget pbx=<null> local=1 type=1
2837139745mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 64
2837139746mS CMCallEvt: 0.12766.0 -1 BaseEP: NEW CMEndpoint f4e63bbc TOTAL NOW=3 CALL_LIST=1
2837139746mS CMTARGET: 0.12766.0 2376 RAS.0: ADD PRIMARY
2837139746mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: ADD VM TARGET: SUCCEEDED
2837139746mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: INITIAL TARGETING SUCCEEDED
2837139746mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: GetNoAnswerTimer:15
2837139746mS CMCallEvt: 17.12764.1 2376 SIPTrunk Endpoint: StateChange: END=A CMCSDialInitiated->CMCSDialled
2837139748mS CMLineTx: v=0
CMProceeding
Line: type=SIPLine 17 Call: lid=17 id=12764 in=1
2837139748mS CMCallEvt: 0.12765.0 2376 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
2837139749mS CMCallEvt: 0.12766.0 2376 RAS.0: StateChange: END=T CMCSIdle->CMCSOffering
2837139749mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 0->12766 )
2837139750mS CMMap: a=21.42 b=1.254 T
2837139752mS CMCallEvt: 0.12766.0 2376 RAS.0: StateChange: END=T CMCSOffering->CMCSConnReq
2837139752mS CMCallEvt: 0.12765.0 2376 TargetingEP: RequestEnd 0.12766.0 2376 RAS.0
2837139752mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: CancelTimer CMTCNoAnswerTimeout
2837139753mS CMExtnEvt: v=1011 State, new=Connected old=Idle,0,0,RAS
2837139753mS CMCallEvt: 17.12764.1 2376 SIPTrunk Endpoint: StateChange: END=A CMCSDialled->CMCSOGConnReq
2837139758mS CMLineTx: v=0
CMConnect
Line: type=SIPLine 17 Call: lid=17 id=12764 in=1
BChan: slot=21 chan=42
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=AutoAtt1
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:102 N:100 R:4) number=AutoAtt1
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=8 class=CMDeviceVoicemail type=0 number=0 channel=42 rx_gain=32 tx_gain=32 ep_callid=12766 ipaddr=172.16.10.2 apps=8
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
ConnectedName.Invoke.CodePageISO8859-1
invokeId 17744
user 'AutoAtt1' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
2837139762mS CMCallEvt: 0.12765.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
2837139762mS CMCallEvt: 0.12765.0 -1 BaseEP: DELETE CMEndpoint f4e14d38 TOTAL NOW=2 CALL_LIST=1
2837139764mS H323Evt: SetOperational 4091 172.16.10.2:0 to 0
2837139764mS H323Evt: SetRfc2833 (1): rx payload 100 tx payload 100
2837139765mS CMMap: PCG::MapBChan pcp[298]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
2837139765mS CMMap: PCGS CPReserveCodec for the other end (pcp[298]b0r1) true
2837139765mS CMMap: PCG::MapBChan pcp[76]b1r0 cp_b f588f494 other_cp_b f58a247c type CGTypeSimple
2837139765mS CMMap: a=0.1 b=21.42 M12
2837139765mS CMMap: PlatformConnectionAudioSAP::ConnectVoice (connect) pcp[298]b0r1 echo_cancellation set to 0
2837139765mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[298]b0r1 Configure 0.1
2837139765mS CMMap: PlatformConnectionAudioSAP::ConnectVoice group 2 rtp_enc_codec 0 rtp_fwd_action 0X00000001 src_fwd_action 0X00000004
2837139765mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Open got rtpRelay ID: 1
2837139766mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Configure success
2837139766mS CMMap: PlatformConnectionAudioSAP::ConnectVoice local IP addr 172.16.10.2:16384, Remote IP addr 12.194.124.75:25250
2837139766mS CMMap: PlatformConnectionAudioSAP::ConnectVoice DSP IP addr 1.1.1.3:32768, telogyHost IP addr 1.1.1.1:10
2837139766mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[298]b0r1 ConnectIndication 0.1
2837139766mS H323Evt: SetOperational 4091 172.16.10.2:16384 to 1
2837139854mS CMLineRx: v=0
CMConnectAck
Line: type=SIPLine 17 Call: lid=17 id=12764 in=1
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Unavailable
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=330XXXXXXX@IP
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=12764 ipaddr=172.16.10.2 apps=8
2837139854mS CMCallEvt: 17.12764.1 2376 SIPTrunk Endpoint: StateChange: END=A CMCSOGConnReq->CMCSConnected
2837139854mS CMTARGET: 17.12764.1 2376 SIPTrunk Endpoint: ~CMTargetHandler f4f0ea28 ep f4ded1d0
2837139856mS CMCallEvt: 0.12766.0 2376 RAS.0: StateChange: END=B CMCSConnReq->CMCSConnected
2837139858mS VMAIL: SESS 4c1: CMD=1 Mailbox=AutoAtt1 Access=4 !Internal!=N
2837139858mS VMAIL: VMAIL Open [VMMESSAGE_OPEN] info :-
2837139858mS VMAIL: Flags :- 65 6e 75 00 00 00 09 48
2837139858mS VMAIL: 00 00 00 66 01 00 00 00
2837139858mS VMAIL: Mailbox: AutoAtt1 Access: 4 !Internal!=N Locale: enu
2837139858mS VMAIL: Calling Party number: 330XXXXXXX Display String: Unavailable>AutoAtt1
2837139858mS VMAIL: Targeted Party number: Called Party number:
2837139859mS VMAIL: Calling Party name: Unavailable Called Party name:
2837139859mS VMAIL: DID number 248XXXXXXX QUEUE: CallAge=0 QueueAge=0 QPos=0 QEta=0 AnnouncmentSync=0
2837139859mS VMAIL: Recording Originator: IP addr. of Recording Originator: 0.0.0.0
2837139859mS VMAIL: Targeted Party Name:
2837139859mS VMAIL: Recording Type: Auto Recording Incoming HuntGroup
2837139859mS VMAIL: Answering Party Number: Answering Party Name:
2837139859mS VMAIL: Targeted Party Offset: 00
2837139859mS VMAIL: Compression Format: input[00] output[00]
2837139859mS VMAIL: Validated Recording: No
2837139859mS VMAIL: UTC Date:
2837139859mS VMAIL: UTC Time:
2837139861mS CMMap: a=21.42 b=0.0 PCGS CPReserveCodec (pcp[298]b0r1) true
2837139861mS CMMap: a=21.42 b=0.0 PCGS CPReserveCodec (pcp[298]b0r1) true
2837139861mS CMMap: PCG::MapBChan pcp[298]b0r1 cp_b f58a247c other_cp_b f588f494 type CGTypeSimple
2837139861mS CMMap: a=21.42 b=0.1 M12
2837140861mS VMAIL: SESS 4c1: CMD=9 Mailbox=AutoAtt1 Access=4 !Internal!=N
2837140861mS VMAIL: VMAIL Open [VMMESSAGE_ACTIVE] info :-
2837140861mS VMAIL: Flags :- 65 6e 75 00 00 00 09 48
2837140861mS VMAIL: 00 00 00 66 01 80 00 00
2837140861mS VMAIL: Mailbox: AutoAtt1 Access: 4 !Internal!=N Locale: enu
2837140861mS VMAIL: Calling Party number: 330XXXXXXX Display String: Unavailable>AutoAtt1
2837140861mS VMAIL: Targeted Party number: Called Party number:
2837140861mS VMAIL: Calling Party name: Unavailable Called Party name:
2837140862mS VMAIL: DID number 248XXXXXXX QUEUE: CallAge=0 QueueAge=0 QPos=0 QEta=0 AnnouncmentSync=0
2837140862mS VMAIL: Recording Originator: IP addr. of Recording Originator: 0.0.0.0
2837140862mS VMAIL: Targeted Party Name:
2837140862mS VMAIL: Recording Type: Auto Recording Incoming HuntGroup
2837140862mS VMAIL: Answering Party Number: Answering Party Name:
2837140862mS VMAIL: Targeted Party Offset: 00
2837140862mS VMAIL: Compression Format: input[00] output[00]
2837140862mS VMAIL: Validated Recording: No

 

[intrigrant]

One way audion on what scenario?
Sip trunk to ip phone?
Sip trunk to didgital set?
Sip trunk to analog set?
Sip trunk to VM?
Sip trunk to SIP trunk?
Sip trunk through AA to IP Phone?
I will not sum up all scenarios but you'll get the point : with so much possible scenarios we can impossibly direct you to a solution.
You need to provide more specific info.

 

[driven0]

Sorry for not clarifying.

External source calls us, Customer can hear us, we cannot hear customer.
SIP trunk to IP Phone 9611g

Thank you.

 

[intrigrant]

My first thought goes to the firewall, one way or no audio is either a routing problem or a firewall problem.
One thing to try first is to disable direct media path on the ip phones, it may help.

 

[driven0]

First thing I did was uncheck allow direct media path

I thought it might be a firewall issue, but we have all the correct ports open, as we have 5 other locations with the same settings.

This one is a mystery to me. I couldn't see anything in the trace that would indicated any particular problem.

 

[tlpeter]

Does it show RDP or VCM in system status?
I agree with intrigrant as this is routing.
What is your IP route to the provider?
Use monitor to see which IP address the packets are send back.
If you use (example) 172.16.1.1 in your IP route as destination but it is being send to 192.168.1.1 then you will have no sound.
Preferable you can use 0.0.0.0

BAZINGA!

I'm not insane, my mother had me tested!

 

[Bas1234]

What firmware is there running on the 9611?

Try this firmware; ftp://ftp.avaya.com/incoming/Up1cku9/tsoweb/9600/01212013/96x1-IPT-H323-R6_2_3_13-011613.zip

Use the following files from below;

-96x1Hupgrade.txt -mlf_S96x1_v76_XXXXXXX.txt

-S96x1_UKR_V13r61_V13r61.tar

-S9608_11HALBR6_2_3_13_V452.tar

-S9621_41HALBR6_2_3_13_V452.tar

Through the Manager (embedded file management) you can put the files on the server in the primary folder, then restart the IP Phones that will now be upgraded from version 6.2.2.09> 6.2.3.13!

___________________________________________
It works! Now if only I could remember what I did...

Dain Bramaged (Avaya Search tool

http://tinyurl.com/bas1234

)
______________________________________

 

[driven0]

@tlpeter
For our Lan1
IP Address 0.0.0.0
IP Mask 0.0.0.0
Gateway 192.168.XX.XXX

I believe the route is right, but I will follow the trace to see what's being sent.

@Bas1234
I will try that if all else fails. The other locations are all on the same firmware and don't have these issues which leads me to believe that's not the problem, but you never know - it could be.


Excuse my lack of info on this one, but would this make any difference.... On the extensions for supplementary service we have it set as None but there is a H450 option, could/would this make any difference?

 

[driven0]

Here's an updated failed call..

I just got this, anything appear out of place?

Thank you as always!


Line: type=SIPLine 17 Call: lid=17 id=13246 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
2920821226mS CMExtnEvt: v=363 State, new=PortRecoverDelay old=Connected,0,0,AgentXX
2920821229mS CMLOGGING: CALL:2013/07/2413:32,00:06:36,006,2307,O,517XXXXXXX@BorderGatewayIP,9517XXXXXXX,AgentXX,,,0,,""n/a,0
2920821229mS CD: CALL: 258.13243.0 BState=Connected Cut=2 Music=0.0 Aend="AgentXX(2307)" (0.0) Bend="Line 17" [Line 17] (0.0) CalledNum=517XXXXXXX@BorderGatewayIP () CallingNum=2307 (AgentXX) Internal=0 Time=408938 AState=Idle
2920821230mS CD: CALL: 258.13243.0 Deleted
2920821230mS CMExtnEvt: AgentXX: CALL LOST (CMCauseNormal)
2920821230mS CMExtnEvt: AgentXX: Extn(2307) Calling Party Number(2307) Type(CMNTypeInternal)
2920821230mS CMExtnEvt: AgentXX: CMExtnHandler::SetCurrent( id: 13243->0 )

 

[Bas1234]

Just upgrade.

http://downloads.avaya.com/css/P8/documents/100169016

Page 18: 27425994 Bad audio on IP Office call server.

___________________________________________
It works! Now if only I could remember what I did...

Dain Bramaged (Avaya Search tool

http://tinyurl.com/bas1234

)
______________________________________

 

[Fahimpm2003]

We had the same problem and solved by changing "Combo card"

We had 2 VCM32 Card and 2 Combo card, one of them had issued with VCM Channels.

Thanks