Incoming SIP Calls Dropping after 25 Minutes

[eartel]

We have an Avaya Server Edition release 11 and SIP trunks with 9608G Telephones. When and incoming DID call is answered by a user and the call exceeds 25 minutes it automatically drops. We can make outbound calls from the same phone but for more than 25 minutes and the call does not drop. If the incoming call is answered from Equinox it does not drop. Any assistance will be appreciated.

 

[Shaun E]

SIP calls dropping after x minutes is almost invariably a firewall timeout issue.

What does your network topology look like?

 

[derfloh]

Sounds more like if the issue is between IPO and the phone. If it were towards WAN it would also affect the Equinox endpoints.

IP Office remote service
Fixed price SIP trunk configuration
CLI based call blocking
SCN fallback over PSTN

 

[eartel]

UPDATE! The calls are not dropping as I earlier stated, we are losing the audio from the far end. In other words the far end can hear us but we cannot hear them after 25 minutes.

 

[eartel]

Here is a sample of when the call loses audio.

020-02-17T13:22:30 938042108mS VOIP: (In) 0a0200660001af5a 2.110426.1 26186 SIPTrunk Endpoint: RearrangeFSProposal 2->2
2020-02-17T13:22:30 938042108mS VOIP: (In) 0a0200660001af5a 2.110426.1 26186 SIPTrunk Endpoint: RearrangeFSProposal 4->4
2020-02-17T13:22:30 938042108mS VOIP: (In) 0a0200660001af5a 2.110426.1 26186 SIPTrunk Endpoint: OnRenegotiate from stack in local LCRIdle, remote LCRIdle, pause is 0 (fs f1f39b98, size 2), renego 1 mh_ch 0 relay 1 resp 1 stream_ch 0 sec_ch 0 dtmf_ch 0 t
38_shuff 0
2020-02-17T13:22:30 938042108mS VOIP: (In) 0a0200660001af5a 2.110426.1 26186 SIPTrunk Endpoint: ... OnRenegotiate caps_fs f1f4d550 size 4 caps_sec 0 size -1
2020-02-17T13:22:30 938042109mS VOIP: (In) 0a0200660001af5a 2.110426.1 26186 SIPTrunk Endpoint: SetRenegotiateState remote LCRIdle -> LCRIdle
2020-02-17T13:22:30 938042109mS VOIP: (In) 0a0200660001af5a 2.110426.1 26186 SIPTrunk Endpoint: CMMediaSession::IsMappable to other media session, sessions don't use same codecs
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: RearrangeFSProposal 2->2
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: AssertSecKey (SetOutSec) reasserted TX key lCG5DBQhMkPVb45lJvyLVKrolB/xj5FCuFp4DMxl crypto 0 MKI 0:0 (previous MKI 0:0)
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: ProcessOutboundFastStart LCMediaConnected --- caps_fs f1f4d550 caps_sec 0
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: OnRenegotiate to stack in local LCRIdle, remote LCRIdle, pause is 0 (fs f1f39b98, size 2), renego 1 mh_ch 0 relay 1 resp 1 stream_ch 0 sec_ch 0 dtmf_ch 0 t38
_shuff 0
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: ... OnRenegotiate caps_fs f1f4d550 size 4 caps_sec 0 size -1
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: IsRenegoFSCompatible: choose a common cap 0
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: AssertSecKey (OnFs inb) reasserted TX key lCG5DBQhMkPVb45lJvyLVKrolB/xj5FCuFp4DMxl crypto 0 MKI 0:0 (previous MKI 0:0)
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: AssertSecKey (OnFS out) reasserted TX key lCG5DBQhMkPVb45lJvyLVKrolB/xj5FCuFp4DMxl crypto 0 MKI 0:0 (previous MKI 0:0)
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: AssertSecKey (OnFs inb) reasserted TX key lCG5DBQhMkPVb45lJvyLVKrolB/xj5FCuFp4DMxl crypto 0 MKI 0:0 (previous MKI 0:0)
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: AssertSecKey (OnFS out) reasserted TX key lCG5DBQhMkPVb45lJvyLVKrolB/xj5FCuFp4DMxl crypto 0 MKI 0:0 (previous MKI 0:0)
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: SetRenegotiateState local LCRIdle -> LCRIdle
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: CMMediaSession::IsMappable to other media session, sessions don't use same codecs
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: ProcessOutboundFastStart other IsSipFullCapsInProgress
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: ProcessOutboundFastStart, respond 1 responded 0 forward 1 other_waits_for_response 0
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: ProcessOutboundFastStart, not responded to reinvite
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: AssertSecKey (SetOutSec) reasserted TX key lCG5DBQhMkPVb45lJvyLVKrolB/xj5FCuFp4DMxl crypto 0 MKI 0:0 (previous MKI 0:0)
2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: AssertSecKey (ProcOutFS) reasserted TX key lCG5DBQhMkPVb45lJvyLVKrolB/xj5FCuFp4DMxl crypto 0 MKI 0:0 (previous MKI 0:0)
2020-02-17T13:22:30 938042109mS CMExtnTxC: v=5285

 

[janni78]

DO you have SIP enabled in the trace, seems there is an REINVITE sent that is unanswered

2020-02-17T13:22:30 938042109mS VOIP: (Out) 0a0200660001af5c 603.110428.0 26186 Joshua Brooks.0: ProcessOutboundFastStart, not responded to reinvite

"Trying is the first step to failure..." - Homer