cancel
Showing results for 
Show  only  | Search instead for 
Did you mean: 
tonysprout
New Contributor

SIP/PRI No Service In or out

Jump to solution

I believe issue is with Caller ID. TA908e 3rd. Outgoing calls get a fast busy. I can see the channel being accessed, then times-out. Incoming calls are directed to a failover automated attendant in the cloud. Incoming calls also access the channel first before being redirected.

DEBUG:

15:41:26.788 SIP.STACK MSG     Rx: UDP src=198.58.42.157:5060 dst=24.154.126.17:5060

15:41:26.788 SIP.STACK MSG         INVITE sip:sip0000001_xxxx@24.154.126.17:5060;transport=UDP SIP/2.0

15:41:26.788 SIP.STACK MSG         Record-Route: <sip:198.58.42.157;lr=on;ftag=as39e43141;nat=yes>

15:41:26.789 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bK796d.519f586.0

15:41:26.789 SIP.STACK MSG         Route: <sip:24.154.126.17:5060;lr>

15:41:26.789 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.43.178:5060;received=198.58.43.178;branch=z9hG4bK220c1b1e;rport=5060

15:41:26.789 SIP.STACK MSG         Max-Forwards: 69

15:41:26.789 SIP.STACK MSG         From: '7249340000' <sip:7249340000@198.58.43.178>;tag=as39e43141

15:41:26.790 SIP.STACK MSG         To: <sip:7242000000@198.58.42.157>

15:41:26.790 SIP.STACK MSG         Contact: <sip:7249340000@198.58.43.178:5060>

15:41:26.790 SIP.STACK MSG         Call-ID: 7429af41222136aa422582553465ca11@198.58.43.178:5060

15:41:26.790 SIP.STACK MSG         CSeq: 102 INVITE

15:41:26.790 SIP.STACK MSG         User-Agent: ISPPBX

15:41:26.790 SIP.STACK MSG         Date: Mon, 20 Nov 2017 20:41:26 GMT

15:41:26.791 SIP.STACK MSG         Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

15:41:26.791 SIP.STACK MSG         Supported: replaces, timer

15:41:26.791 SIP.STACK MSG         P-Peer-Name: sip0000001_xxxx

15:41:26.791 SIP.STACK MSG         Content-Type: application/sdp

15:41:26.791 SIP.STACK MSG         Content-Length: 267

15:41:26.791 SIP.STACK MSG    

15:41:26.792 SIP.STACK MSG         v=0

15:41:26.792 SIP.STACK MSG         o=root 1854271231 1854271231 IN IP4 198.58.43.178

15:41:26.792 SIP.STACK MSG         s=Asterisk PBX 1.8.15-cert2

15:41:26.792 SIP.STACK MSG         c=IN IP4 198.58.43.178

15:41:26.792 SIP.STACK MSG         t=0 0

15:41:26.792 SIP.STACK MSG         m=audio 23750 RTP/AVP 0 8 101

15:41:26.793 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

15:41:26.793 SIP.STACK MSG         a=rtpmap:8 PCMA/8000

15:41:26.793 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

15:41:26.793 SIP.STACK MSG         a=fmtp:101 0-16

15:41:26.793 SIP.STACK MSG         a=ptime:20

15:41:26.794 SIP.STACK MSG         a=sendrecv

15:41:26.794 SIP.STACK MSG    

15:41:26.798 SIP.CLDU Cldu::CallLegCreatedEv: Incoming CallLeg created from 7249340000@198.58.43.178:5060 to sip0000001_xxxx@24.154.126.17:5060

15:41:26.798 SIP.CLDU Searching for a matching trunk account by Via (198.58.42.157:5060 - UDP)

15:41:26.799 SIP.CLDU findClduInterface: 198.58.42.157 match to domain address (via DNS) succeeded for T01

15:41:26.800 SIP.CLDU Routing call to trunk from 7249340000

15:41:26.800 SIP.CLDU Incoming message received from 198.58.42.157:5060 via UDP

15:41:26.801 TM.T01 01 SipTM_Idle           rcvd SIP call-leg request: INVITE

15:41:26.801 SIP.CLDU Cldu::CallLegStateChangedEv: (0x0x4facb0b8)->Offering

15:41:26.801 TM.T01 01 SipTM_Idle           call-leg -> Offering

15:41:26.802 TM.T01 01 SipTM_Idle           State change      >> SipTM_Idle->SipTM_Trying

15:41:26.802 TM.T01 01 SipTM_Trying         SDP offer is not loopback request

15:41:26.803 TM.T01 01 SipTM_Trying         Processing From for Caller-ID.

15:41:26.803 TM.T01 01 SipTM_Trying         Caller ID Name   = '7249340000'

15:41:26.803 TM.T01 01 SipTM_Trying         Caller ID Number = '7249340000'

15:41:26.803 TM.T01 01 SipTM_Trying         info: unable to set redirect number(s) from INVITE

15:41:26.804 TM.T01 01 SipTM_Trying         sent: TA->InboundCall

15:41:26.804 TM.T01 01 Looking up source address for destination 198.58.42.157

15:41:26.804 TM.T01 01 call-leg (0x0x4facb0b8) -> src: 24.154.126.17 : 5060  dst: 198.58.42.157 : 5060

15:41:26.806 SIP.STACK MSG     Tx: UDP src=24.154.126.17:5060 dst=198.58.42.157:5060

15:41:26.807 SIP.STACK MSG         SIP/2.0 100 Trying

15:41:26.807 SIP.STACK MSG         From: '7249340000'<sip:7249340000@198.58.43.178>;tag=as39e43141

15:41:26.807 SIP.STACK MSG         To: <sip:7242000000@198.58.42.157>

15:41:26.807 SIP.STACK MSG         Call-ID: 7429af41222136aa422582553465ca11@198.58.43.178:5060

15:41:26.807 SIP.STACK MSG         CSeq: 102 INVITE

15:41:26.808 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bK796d.519f586.0

15:41:26.808 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.43.178:5060;received=198.58.43.178;rport=5060;branch=z9hG4bK220c1b1e

15:41:26.808 SIP.STACK MSG         Contact: <sip:sip0000001_xxxx@24.154.126.17:5060;transport=UDP>

15:41:26.808 SIP.STACK MSG         Supported: 100rel,replaces

15:41:26.808 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

15:41:26.808 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908e_3rd_Gen/R12.3.1.E

15:41:26.809 SIP.STACK MSG         Content-Length: 0

15:41:26.809 SIP.STACK MSG    

15:41:26.809 TM.T01 01 SipTM_Trying         sent: 100 Trying

15:41:26.810 TA.T01 01 TAIdle               rcvd: inboundCall from TM

15:41:26.810 TA.T01 01 State change      >> TAIdle->TAInboundCall (TAS_Calling)

15:41:26.810 TA.T01 01 Failed - DID translation: no match for sip0000001_xxxx, using sip0000001_xxxx

15:41:26.811 TA.T01 01 TAIdle               sent: call to SB

15:41:26.811 TM.T01 01 SipTM_Trying         tachg -> TAInboundCall

15:41:26.812 TM.T01 01 SipTM_Trying         State change      >> SipTM_Trying->SipTM_Pending

15:41:26.812 SB.CALL 64 Idle                 Called the call routine with sip0000001_xxxx

15:41:26 SB.TGMgr For dialed number sip0000001_xxxx, against template $, on TrunkGroup PRI, the score is 500

15:41:26 SB.TGMgr For dialed number sip0000001_xxxx, against template $, on TrunkGroup SIP, the score is 500

15:41:26.813 SB.CCM isMappable:

15:41:26.813 SB.CCM  :  Call Struct 0x0x502b2010 :   Call-ID = 64

15:41:26.813 SB.CCM  :  Org Acct = T01    Dst Acct = T02

15:41:26.813 SB.CCM  :  Org Port ID = SipTrunk 0/0   Dst Port ID = unknown 0/0

15:41:26.813 SB.CCM  :  SDP Transaction = CallID: 64

15:41:26.814 SB.CCM  :  SDP Offer = 0x507e8710, (198.58.43.178:23750)

15:41:26.814 SB.CCM isMappable: Call Connection Type is RTP_TO_TDM

15:41:26.814 SB.CCM isMappable: Reserving RTP Channel 0/1.1

15:41:26.815 SB.CCM translateOffer: offer codec list: PCMU PCMA

15:41:26.815 SB.CCM translateOffer: revised offer codec list: PCMU

15:41:26.816 SB.CCM translateOffer: codec list after answerer: PCMU

15:41:26.816 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through

15:41:26.817 SB.CCM translateOffer: success

15:41:26.818 SB.CALL 64 Idle                 Call sent from T01 to T02 (sip0000001_xxxx)

15:41:26.818 SB.CALL 64 State change      >> Idle->Delivering

15:41:26.818 RTP.MANAGER Isdn(Group) 0/ - empty - RTP: Reserve resource

15:41:26.818 RTP.MANAGER Isdn(Group) 0/ - Dsp 0/1.1 - RTP:

15:41:26.819 RTP.PROVIDER unknown - Dsp 0/1.1 - RTP: reserving already allocated RTP channel

15:41:26.819 TA.T01 01 TAInboundCall        CallResp event accepted

15:41:26.819 TA.T01 01 State change      >> TAInboundCall->TAConnectWaitIn (TAS_Calling)

15:41:26.819 TA.T02 01 State change      >> TAIdle->TAOutGoing (TAS_Delivering)

15:41:26.820 TM.T02 01 tachg_Delivering

15:41:26.820 TM.T02 01 IsdnTmStateIdle->IsdnTmStateOutboundDeliver

15:41:26.820 TM.T02 01 IsdnTmStateOutboundDeliver::enter()

15:41:26.821 ISDN.L2_FMT PRI  1  ==============================================

15:41:26.821 ISDN.L2_FMT PRI  1  T Sapi:00 C/R:C Tei:00 INFO Ns:78  Nr:50  P:0

15:41:26.821 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:0010

15:41:26.821 ISDN.L2_FMT PRI  1    M - 05 SETUP      

15:41:26.821 ISDN.L2_FMT PRI  1     IE - 04 BEARER CAPABILITY   Len=3

15:41:26.821 ISDN.L2_FMT PRI  1          80 Xfer Cap.:SPEECH           

15:41:26.821 ISDN.L2_FMT PRI  1          90 Xfer Rate:64k  

15:41:26.821 ISDN.L2_FMT PRI  1          A2 Layer 1:G.711 U-Law   

15:41:26.822 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID          Len=3

15:41:26.822 ISDN.L2_FMT PRI  1          A1 Primary Rate

15:41:26.822 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT

15:41:26.822 ISDN.L2_FMT PRI  1             Pref/Excl:PREFERRED

15:41:26.822 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO

15:41:26.822 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS

15:41:26.822 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER

15:41:26.822 ISDN.L2_FMT PRI  1          81 Channel:1

15:41:26.823 ISDN.L2_FMT PRI  1     IE - 1C FACILITY            Len=24

15:41:26.823 ISDN.L2_FMT PRI  1      Calling Name: 7249340000

15:41:26.823 ISDN.L2_FMT PRI  1     IE - 6C CALLING PARTY #     Len=12

15:41:26.824 ISDN.L2_FMT PRI  1          00 Numb. Type:UNKNOWN      

15:41:26.824 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN       

15:41:26.824 ISDN.L2_FMT PRI  1          80 Presentation:ALLOWED    

15:41:26.824 ISDN.L2_FMT PRI  1             Screening:USER PROVIDED

15:41:26.824 ISDN.L2_FMT PRI  1             Ph.# 7242000000

15:41:26.824 ISDN.L2_FMT PRI  1     IE - 70 CALLED PARTY #      Len=1

15:41:26.824 ISDN.L2_FMT PRI  1          80 Numb. Type:UNKNOWN      

15:41:26.824 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN       

15:41:26.825 ISDN.L2_FMT PRI  1             Ph.#

15:41:26.825 SB.CALL 64 Delivering           Called the deliverResponse routine from Delivering

15:41:26.825 SB.CALL 64 Delivering           DeliverResponse(accept) sent from T02 to T01

15:41:26.825 TA.T01 01 TAConnectWaitIn      deliverResponse event accepted

15:41:26.825 TA.T01 01 TAConnectWaitIn      ERROR! deliverResponse ignored

15:41:26.841 ISDN.L2_FMT PRI  1  ==============================================

15:41:26.841 ISDN.L2_FMT PRI  1  R Sapi:00 C/R:R Tei:00 INFO Ns:50  Nr:79  P:0

15:41:26.841 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:8010

15:41:26.842 ISDN.L2_FMT PRI  1    M - 02 CALL_PROC  

15:41:26.842 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID          Len=3

15:41:26.842 ISDN.L2_FMT PRI  1          A9 Primary Rate

15:41:26.842 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT

15:41:26.842 ISDN.L2_FMT PRI  1             Pref/Excl:EXCLUSIVE

15:41:26.842 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO

15:41:26.842 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS

15:41:26.842 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER

15:41:26.843 ISDN.L2_FMT PRI  1          81 Channel:1

15:41:26 SB.CallStructObserver 64 Created

15:41:26 SB.CallStructObserver 64 <-> 7429af41222136aa422582553465ca11@198.58.43.178:5060

15:41:37.350 ISDN.L2_FMT PRI  1  ==============================================

15:41:37.350 ISDN.L2_FMT PRI  1  T Sapi:00 C/R:C Tei:00 INFO Ns:79  Nr:51  P:0

15:41:37.350 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:0010

15:41:37.350 ISDN.L2_FMT PRI  1    M - 45 DISCONNECT 

15:41:37.350 ISDN.L2_FMT PRI  1     IE - 08 CAUSE               Len=2

15:41:37.351 ISDN.L2_FMT PRI  1          82 Location:LN

15:41:37.351 ISDN.L2_FMT PRI  1          E6 Cause:102 (TIMER_EXPIRY)

15:41:37.351 ISDN.L2_FMT PRI  1  ==============================================

15:41:37.351 ISDN.L2_FMT PRI  1  T Sapi:00 C/R:C Tei:00 INFO Ns:80  Nr:51  P:0

15:41:37.352 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:0010

15:41:37.352 ISDN.L2_FMT PRI  1    M - 4D RELEASE    

15:41:37.352 ISDN.L2_FMT PRI  1     IE - 08 CAUSE               Len=2

15:41:37.352 ISDN.L2_FMT PRI  1          82 Location:LN

15:41:37.352 ISDN.L2_FMT PRI  1          E0 Cause:96 (MANDATORY_IE_MISSING)

15:41:37.352 TM.T02 01 IsdnTmStateOutboundDeliver->IsdnTmStateTrunkClearing

15:41:37.352 TM.T02 01 IsdnTmStateTrunkClearing::enter()

15:41:37.353 TA.T02 01 TAOutGoing           rcvd: clear from TM

15:41:37.353 TA.T02 01 State change      >> TAOutGoing->TATrunkClearing (TAS_Clearing)

15:41:37.353 SB.CALL 64 Delivering           Called the clearCall routine

15:41:37.354 SB.CALL 64 Delivering           SIP Proxy rejected call to sip0000001_xxxx for survivability - no matching Proxy user

15:41:37.354 SB.CALL 64 Delivering           No available resources on call from T01 to T02 (last attempt)

15:41:37.354 SB.CALL 64 State change      >> Delivering->Clearing

15:41:37.354 TA.T01 01 TAConnectWaitIn      ClearCall event accepted

15:41:37.354 TA.T01 01 State change      >> TAConnectWaitIn->TAClearingComplete (TAS_Clearing)

15:41:37.355 TM.T01 01 SipTM_Pending        tachg -> TAClearingComplete

15:41:37.355 TM.T01 01 SipTM_Pending        State change      >> SipTM_Pending->SipTM_CallFail

15:41:37.357 SIP.STACK MSG     Tx: UDP src=24.154.126.17:5060 dst=198.58.42.157:5060

15:41:37.357 SIP.STACK MSG         SIP/2.0 400 Bad Request

15:41:37.357 SIP.STACK MSG         From: '7249340000'<sip:7249340000@198.58.43.178>;tag=as39e43141

15:41:37.357 SIP.STACK MSG         To: <sip:7242000000@198.58.42.157>;tag=4fa37688-7f000001-13c4-2fee0-584bd1ca-2fee0

15:41:37.357 SIP.STACK MSG         Call-ID: 7429af41222136aa422582553465ca11@198.58.43.178:5060

15:41:37.357 SIP.STACK MSG         CSeq: 102 INVITE

15:41:37.358 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bK796d.519f586.0

15:41:37.358 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.43.178:5060;received=198.58.43.178;rport=5060;branch=z9hG4bK220c1b1e

15:41:37.358 SIP.STACK MSG         Supported: 100rel,replaces

15:41:37.358 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

15:41:37.358 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908e_3rd_Gen/R12.3.1.E

15:41:37.359 SIP.STACK MSG         Content-Length: 0

15:41:37.359 SIP.STACK MSG    

15:41:37.360 SIP.CLDU Cldu::CallLegStateChangedEv: (0x0x4facb0b8)->Disconnected

15:41:37.360 TM.T01 01 SipTM_CallFail       call-leg -> Disconnected

15:41:37.360 TM.T01 01 SipTM_CallFail       CallLegStateChanged to Disconnected - TM change to closing state.

15:41:37.361 TM.T01 01 SipTM_CallFail       State change      >> SipTM_CallFail->SipTM_Closing

15:41:37.361 TM.T01 01 SipTM_Closing        sent: TA->Clear

15:41:37.361 TM.T01 01 SipTM_CallFail       sent: 0

15:41:37.361 TM.T01 01 SipTM_Closing        State change      >> SipTM_Closing->SipTM_Terminated

15:41:37.361 TM.T01 01 SipTM_Terminated     sent: TA->AppearanceOff

15:41:37.362 TM.T01 01 SipTM_Terminated     State change      >> SipTM_Terminated->SipTM_Idle

15:41:37.362 ISDN.L2_FMT PRI  1  ==============================================

15:41:37.362 ISDN.L2_FMT PRI  1  R Sapi:00 C/R:R Tei:00 INFO Ns:51  Nr:81  P:0

15:41:37.362 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:8010

15:41:37.362 ISDN.L2_FMT PRI  1    M - 5A RELEASE_CMP

15:41:37.363 TM.T02 01 IsdnTmStateTrunkClearing->IsdnTmStateIdling

15:41:37.363 TM.T02 01 IsdnTmStateIdling::enter()

15:41:37.363 TM.T02 01 IsdnTmStateIdling - send appearance off

15:41:37.363 TM.T02 01 IsdnTmStateIdling->IsdnTmStateIdle

15:41:37.363 TM.T02 01 IsdnAppearanceChannel::releaseChannel

15:41:37.363 TM.T02 01 IsdnTmStateIdle::enter()

15:41:37.364 SB.CALL 64 Clearing             Called the clearResponse routine

15:41:37.364 SB.CALL 64 State change      >> Clearing->CallIdlePending

15:41:37.364 SB.CCM release:

15:41:37.365 SB.CCM  :  Call Struct 0x0x502b2010 :   Call-ID = 64

15:41:37.365 SB.CCM  :  Org Acct = T01    Dst Acct = T02

15:41:37.365 SB.CCM  :  Org Port ID = SipTrunk 0/0   Dst Port ID = Isdn(Group) 0/0

15:41:37.365 SB.CCM  :  SDP Transaction = CallID: 64

15:41:37.365 SB.CCM  :  SDP Offer = 0x507e8710, (198.58.43.178:23750)

15:41:37.366 SB.CCM  :  Offer side SRTP session details

15:41:37.366 SB.CCM  :    None

15:41:37.366 SB.CCM  :  Answer side SRTP session details

15:41:37.366 SB.CCM  :    None

15:41:37.366 SB.CCM  :  RTP Channel = 0/1.1

15:41:37.366 SB.CCM release: Call Connection Type is RTP_TO_TDM

15:41:37.366 SB.CCM release: Releasing RTP Channel 0/1.1

15:41:37.367 RTP.CHANNEL RtpChannel::deallocate, status = 2, allocatedForInterface = 0

15:41:37.367 RTP.CHANNEL Channel 0/1.1 released successfully.

15:41:37.367 SB.CALL 64 CallIdlePending      ClearResponse sent from T01 to T02

15:41:37.367 TA.T01 01 TAClearingComplete   rcvd: clear from TM

15:41:37.368 TA.T01 01 TAClearingComplete   rcvd: appearance off from TM

15:41:37.368 TA.T01 01 TAClearingComplete   Clear Local Variables

15:41:37.368 TA.T01 01 State change      >> TAClearingComplete->TAIdle (TAS_Idle)

15:41:37.368 TM.T01 01 SipTM_Idle           tachg -> TAIdle

15:41:37.369 TA.T02 01 TATrunkClearing      rcvd: appearance off from TM

15:41:37.369 TA.T02 01 State change      >> TATrunkClearing->TAClearingComplete (TAS_Clearing)

15:41:37.369 TA.T02 01 TATrunkClearing      Processing an appearance OFF

15:41:37.369 TA.T02 01 TAClearingComplete   clearResponse event accepted

15:41:37.369 TA.T02 01 TAClearingComplete   Clear Local Variables

15:41:37.370 TA.T02 01 State change      >> TAClearingComplete->TAIdle (TAS_Idle)

15:41:37.370 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing RTP resource

15:41:37.370 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing

15:41:37 SB.CallStructObserver 64 Finalized

15:41:37.404 SIP.STACK MSG     Rx: UDP src=198.58.42.157:5060 dst=24.154.126.17:5060

15:41:37.405 SIP.STACK MSG         ACK sip:sip0000001_xxxx@24.154.126.17:5060;transport=UDP SIP/2.0

15:41:37.405 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bK796d.519f586.0

15:41:37.405 SIP.STACK MSG         Route: <sip:24.154.126.17:5060;lr>

15:41:37.405 SIP.STACK MSG         Max-Forwards: 69

15:41:37.405 SIP.STACK MSG         From: '7249340000' <sip:7249340000@198.58.43.178>;tag=as39e43141

15:41:37.406 SIP.STACK MSG         To: <sip:7242000000@198.58.42.157>;tag=4fa37688-7f000001-13c4-2fee0-584bd1ca-2fee0

15:41:37.406 SIP.STACK MSG         Call-ID: 7429af41222136aa422582553465ca11@198.58.43.178:5060

15:41:37.406 SIP.STACK MSG         CSeq: 102 ACK

15:41:37.406 SIP.STACK MSG         Content-Length: 0

15:41:37.406 SIP.STACK MSG    

15:41:37.408 SIP.STACK MSG Found existing transaction for the request message.

15:41:37.408 SIP.CLDU Incoming message received from 198.58.42.157:5060 via UDP

15:41:37.409 SIP.CLDU Cldu::CallLegStateChangedEv: (0x0x4facb0b8)->Terminated

2017.11.20 15:41:38 SMDR 64         11/20/2017 15:41:26      0.2 0    E  00/00 7249340000      7242000000      00/00 T02             sip0000001_xxxn 0 N 

15:42:05.800 SIP.STACK MSG     Rx: UDP src=198.58.42.157:5060 dst=24.154.126.17:5060

15:42:05.800 SIP.STACK MSG         OPTIONS sip:sip0000001_xxxx@24.154.126.17:5060;transport=UDP SIP/2.0

15:42:05.800 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bKc1e6.a083b0f5.0

15:42:05.800 SIP.STACK MSG         Route: <sip:24.154.126.17:5060;lr>

15:42:05.801 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.43.178:5060;received=198.58.43.178;branch=z9hG4bK3f540e39;rport=5060

15:42:05.801 SIP.STACK MSG         Max-Forwards: 69

15:42:05.801 SIP.STACK MSG         From: 'NOCALLERID' <sip:NOCALLERID@198.58.43.178>;tag=as12ec1dd1

15:42:05.801 SIP.STACK MSG         To: <sip:sip0000001_xxxx@198.58.42.157:5060>

15:42:05.801 SIP.STACK MSG         Contact: <sip:NOCALLERID@198.58.43.178:5060>

15:42:05.801 SIP.STACK MSG         Call-ID: 6642f6975c1925f93394b554635674f4@198.58.43.178:5060

15:42:05.802 SIP.STACK MSG         CSeq: 102 OPTIONS

15:42:05.802 SIP.STACK MSG         User-Agent: ISPPBX

15:42:05.802 SIP.STACK MSG         Date: Mon, 20 Nov 2017 20:42:05 GMT

15:42:05.802 SIP.STACK MSG         Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

15:42:05.802 SIP.STACK MSG         Supported: replaces, timer

15:42:05.803 SIP.STACK MSG         Content-Length: 0

15:42:05.803 SIP.STACK MSG    

15:42:05.807 SIP.STACK MSG     Tx: UDP src=24.154.126.17:5060 dst=198.58.42.157:5060

15:42:05.807 SIP.STACK MSG         SIP/2.0 501 Not Implemented

15:42:05.807 SIP.STACK MSG         From: 'NOCALLERID'<sip:NOCALLERID@198.58.43.178>;tag=as12ec1dd1

15:42:05.807 SIP.STACK MSG         To: <sip:sip0000001_xxxx@198.58.42.157:5060>;tag=4fa37858-7f000001-13c4-2fefc-118ea8e1-2fefc

15:42:05.808 SIP.STACK MSG         Call-ID: 6642f6975c1925f93394b554635674f4@198.58.43.178:5060

15:42:05.808 SIP.STACK MSG         CSeq: 102 OPTIONS

15:42:05.808 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bKc1e6.a083b0f5.0

15:42:05.808 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.43.178:5060;received=198.58.43.178;rport=5060;branch=z9hG4bK3f540e39

15:42:05.808 SIP.STACK MSG         Content-Length: 0

15:42:05.808 SIP.STACK MSG    

15:43:05.890 SIP.STACK MSG     Rx: UDP src=198.58.42.157:5060 dst=24.154.126.17:5060

15:43:05.890 SIP.STACK MSG         OPTIONS sip:sip0000001_xxxx@24.154.126.17:5060;transport=UDP SIP/2.0

15:43:05.891 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bKe009.4071e153.0

15:43:05.891 SIP.STACK MSG         Route: <sip:24.154.126.17:5060;lr>

15:43:05.891 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.43.178:5060;received=198.58.43.178;branch=z9hG4bK65559687;rport=5060

15:43:05.891 SIP.STACK MSG         Max-Forwards: 69

15:43:05.891 SIP.STACK MSG         From: 'NOCALLERID' <sip:NOCALLERID@198.58.43.178>;tag=as5ccbb4f8

15:43:05.892 SIP.STACK MSG         To: <sip:sip0000001_xxxx@198.58.42.157:5060>

15:43:05.892 SIP.STACK MSG         Contact: <sip:NOCALLERID@198.58.43.178:5060>

15:43:05.892 SIP.STACK MSG         Call-ID: 1e0ba5524fd37c9668fe509e2f2c10d1@198.58.43.178:5060

15:43:05.892 SIP.STACK MSG         CSeq: 102 OPTIONS

15:43:05.892 SIP.STACK MSG         User-Agent: ISPPBX

15:43:05.893 SIP.STACK MSG         Date: Mon, 20 Nov 2017 20:43:05 GMT

15:43:05.893 SIP.STACK MSG         Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

15:43:05.893 SIP.STACK MSG         Supported: replaces, timer

15:43:05.893 SIP.STACK MSG         Content-Length: 0

15:43:05.893 SIP.STACK MSG    

15:43:05.897 SIP.STACK MSG     Tx: UDP src=24.154.126.17:5060 dst=198.58.42.157:5060

15:43:05.898 SIP.STACK MSG         SIP/2.0 501 Not Implemented

15:43:05.898 SIP.STACK MSG         From: 'NOCALLERID'<sip:NOCALLERID@198.58.43.178>;tag=as5ccbb4f8

15:43:05.898 SIP.STACK MSG         To: <sip:sip0000001_xxxx@198.58.42.157:5060>;tag=4fa37a28-7f000001-13c4-2ff38-67230e3d-2ff38

15:43:05.898 SIP.STACK MSG         Call-ID: 1e0ba5524fd37c9668fe509e2f2c10d1@198.58.43.178:5060

15:43:05.898 SIP.STACK MSG         CSeq: 102 OPTIONS

15:43:05.898 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.42.157:5060;branch=z9hG4bKe009.4071e153.0

15:43:05.899 SIP.STACK MSG         Via: SIP/2.0/UDP 198.58.43.178:5060;received=198.58.43.178;rport=5060;branch=z9hG4bK65559687

15:43:05.899 SIP.STACK MSG         Content-Length: 0

15:43:05.899 SIP.STACK MSG    

15:43:48.527 ISDN.L2_FMT PRI  1  ==============================================

15:43:48.527 ISDN.L2_FMT PRI  1  R Sapi:00 C/R:R Tei:00 INFO Ns:52  Nr:81  P:0

15:43:48.527 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:0031

15:43:48.527 ISDN.L2_FMT PRI  1    M - 05 SETUP      

15:43:48.527 ISDN.L2_FMT PRI  1     IE - 04 BEARER CAPABILITY   Len=3

15:43:48.527 ISDN.L2_FMT PRI  1          80 Xfer Cap.:SPEECH           

15:43:48.527 ISDN.L2_FMT PRI  1          90 Xfer Rate:64k  

15:43:48.528 ISDN.L2_FMT PRI  1          A2 Layer 1:G.711 U-Law   

15:43:48.528 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID          Len=3

15:43:48.528 ISDN.L2_FMT PRI  1          A9 Primary Rate

15:43:48.528 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT

15:43:48.528 ISDN.L2_FMT PRI  1             Pref/Excl:EXCLUSIVE

15:43:48.528 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO

15:43:48.528 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS

15:43:48.528 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER

15:43:48.529 ISDN.L2_FMT PRI  1          97 Channel:23

15:43:48.529 ISDN.L2_FMT PRI  1     IE - 70 CALLED PARTY #      Len=11

15:43:48.529 ISDN.L2_FMT PRI  1          A0 Numb. Type:NATIONAL     

15:43:48.529 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN       

15:43:48.529 ISDN.L2_FMT PRI  1             Ph.# 4126069785

15:43:48.530 ISDN.L2_FMT PRI  1  ==============================================

15:43:48.530 ISDN.L2_FMT PRI  1  T Sapi:00 C/R:C Tei:00 INFO Ns:81  Nr:53  P:0

15:43:48.530 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:8031

15:43:48.531 ISDN.L2_FMT PRI  1    M - 02 CALL_PROC  

15:43:48.531 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID          Len=3

15:43:48.531 ISDN.L2_FMT PRI  1          A9 Primary Rate

15:43:48.531 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT

15:43:48.531 ISDN.L2_FMT PRI  1             Pref/Excl:EXCLUSIVE

15:43:48.531 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO

15:43:48.531 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS

15:43:48.531 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER

15:43:48.532 ISDN.L2_FMT PRI  1          97 Channel:23

15:43:48.532 TM.T02 23 en bloc sending call rec'd

15:43:48.532 TM.T02 23 IsdnTmStateIdle->IsdnTmStateInboundAccept

15:43:48.532 TM.T02 23 IsdnTmStateInboundAccept::enter() send call to acct

15:43:48.532 TA.T02 23 TAIdle               rcvd: inboundCall from TM

15:43:48.533 TA.T02 23 State change      >> TAIdle->TAInboundCall (TAS_Calling)

15:43:48.533 TA.T02 23 Failed - DID translation: no match for 4126069785, using 4126069785

15:43:48.533 TA.T02 23 TAIdle               sent: call to SB

15:43:48.533 TM.T02 23 tachg_TAInboundCall do nothing

15:43:48.534 SB.CALL 65 Idle                 Called the call routine with 4126069785

15:43:48 SB.TGMgr For dialed number 4126069785, against template NXX-NXX-XXXX, on TrunkGroup PRI, the score is 1000

15:43:48 SB.TGMgr For dialed number 4126069785, against template $, on TrunkGroup SIP, the score is 500

15:43:48.534 SB.CCM isMappable:

15:43:48.534 SB.CCM  :  Call Struct 0x0x502b2010 :   Call-ID = 65

15:43:48.535 SB.CCM  :  Org Acct = T02    Dst Acct = T01

15:43:48.535 SB.CCM  :  Org Port ID = Isdn(Ds1Ds0Trunk) 0/4.23   Dst Port ID = unknown 0/0

15:43:48.535 SB.CCM isMappable: Call Connection Type is TDM_TO_RTP

15:43:48.535 RTP.CHANNEL allocateForInterface 0/1.1, status = 1, allocatedForInterface = 0

15:43:48.536 SB.CCM isMappable: Reserving RTP Channel 0/1.1

15:43:48.536 SB.CCM isMappable: Creating SDP Offer

15:43:48.537 SB.CCM updateOfferWithEndpointConfig: DTMF(NTE 101), VAD(off), ptime(0)

15:43:48.538 SB.CCM translateOffer: offer codec list: PCMU

15:43:48.538 SB.CCM translateOffer: revised offer codec list: PCMU

15:43:48.538 SB.CCM translateOffer: codec list after answerer: PCMU

15:43:48.539 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through

15:43:48.540 SB.CCM translateOffer: success

15:43:48.541 SB.CALL 65 Idle                 Call sent from T02 to T01 (4126069785)

15:43:48.541 SB.CALL 65 State change      >> Idle->Delivering

15:43:48.542 RTP.MANAGER t1 0/4.23 - empty - RTP: Request resource

15:43:48.542 RTP.MANAGER t1 0/4.23 - Dsp 0/1.1 - RTP: DSP channel allocated for the resource

15:43:48.542 RTP.PROVIDER t1 0/4.23 - Dsp 0/1.1 - RTP: providing already allocated RTP channel

15:43:48.542 TA.T02 23 TAInboundCall        CallResp event accepted

15:43:48.542 TA.T02 23 State change      >> TAInboundCall->TAConnectWaitIn (TAS_Calling)

15:43:48.543 TA.T01 55 State change      >> TAIdle->TAOutGoing (TAS_Delivering)

15:43:48.543 TM.T01 55 SipTM_Idle           State change      >> SipTM_Idle->Delivering

15:43:48.544 TM.T01 55 Delivering           Applying E.164 settings to called party number (4126069785)

15:43:48.544 TM.T01 55 Delivering           Skipping E.164 conversion due to voice international-prefix setting

15:43:48.544 TM.T01 55 Delivering           setupRvCallLeg: Calling party number is empty

15:43:48.544 TM.T01 55 Looking up source address for destination 198.58.42.157

15:43:48.545 TM.T01 55 call-leg (0x0x4facb2c0) -> src: 24.154.126.17 : 5060  dst: 198.58.42.157 : 5060

15:43:48.545 TM.T01 55 SDP DPI call ID 65 : No media bin.

15:43:48.546 TM.T01 55 Processing new SDP entries.

15:43:48.546 TM.T01 55 Checking for internal Media Gateway IP Address

15:43:48.546 TM.T01 55 Using RTP Channel 0/1.1

15:43:48.546 SIP.CLDU Looking up source address for destination 198.58.42.157

15:43:48.547 TM.T01 55 Inserting 24.154.126.17 into SDP for Media Gateway

15:43:48.547 TM.T01 55 Adding RTP Media Gateway Entry: 127.0.0.3:10128 -> 24.154.126.17:10128

15:43:48.547 TM.T01 55 Allocating anchor ports 10128 and 10129 for interface 24.154.126.17

15:43:48.550 SIP.STACK MSG     Tx: UDP src=24.154.126.17:5060 dst=198.58.42.157:5060

15:43:48.550 SIP.STACK MSG         INVITE sip:4126069785@sip.east.sipregistration.com:5060 SIP/2.0

15:43:48.550 SIP.STACK MSG         From: <sip:sip.east.sipregistration.com:5060;transport=UDP>;tag=4fa37bf8-7f000001-13c4-2ff63-32aab35-2ff63

15:43:48.551 SIP.STACK MSG         To: <sip:4126069785@sip.east.sipregistration.com:5060>

15:43:48.551 SIP.STACK MSG         Call-ID: 4facb2c0-7f000001-13c4-2ff63-6a0e75ce-2ff63@sip.east.sipregistration.com

15:43:48.551 SIP.STACK MSG         CSeq: 1 INVITE

15:43:48.551 SIP.STACK MSG         Via: SIP/2.0/UDP 24.154.126.17:5060;branch=z9hG4bK-2ff63-bb59ba2-38f81ca9

15:43:48.551 SIP.STACK MSG         Max-Forwards: 70

15:43:48.552 SIP.STACK MSG         Supported: 100rel,replaces

15:43:48.552 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

15:43:48.552 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908e_3rd_Gen/R12.3.1.E

15:43:48.552 SIP.STACK MSG         Contact: <sip:24.154.126.17:5060;transport=UDP>

15:43:48.552 SIP.STACK MSG         Content-Type: application/sdp

15:43:48.552 SIP.STACK MSG         Content-Length: 210

15:43:48.553 SIP.STACK MSG    

15:43:48.553 SIP.STACK MSG         v=0

15:43:48.553 SIP.STACK MSG         o=- 1511210628 1 IN IP4 24.154.126.17

15:43:48.553 SIP.STACK MSG         s=-

15:43:48.553 SIP.STACK MSG         c=IN IP4 24.154.126.17

15:43:48.553 SIP.STACK MSG         t=0 0

15:43:48.554 SIP.STACK MSG         m=audio 10128 RTP/AVP 0 101

15:43:48.554 SIP.STACK MSG         a=silenceSupp:off - - - -

15:43:48.554 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

15:43:48.554 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

15:43:48.554 SIP.STACK MSG         a=fmtp:101 0-15

15:43:48.555 SIP.STACK MSG    

15:43:48.555 SIP.CLDU Cldu::CallLegStateChangedEv: (0x0x4facb2c0)->Inviting

15:43:48.556 TM.T01 55 Delivering           call-leg -> Inviting

15:43:48.556 TM.T01 55 Delivering           sent: INVITE

15:43:48.556 SB.CALL 65 Delivering           Called the deliverResponse routine from Delivering

15:43:48.557 SB.CALL 65 Delivering           DeliverResponse(accept) sent from T01 to T02

15:43:48.557 TA.T02 23 TAConnectWaitIn      deliverResponse event accepted

15:43:48.557 TA.T02 23 TAConnectWaitIn      ERROR! deliverResponse ignored

15:43:48 SB.CallStructObserver 65 Created

15:43:49.055 SIP.STACK MSG SIP stack timer retransmit

15:43:49.056 SIP.STACK MSG     Tx: UDP src=24.154.126.17:5060 dst=198.58.42.157:5060

15:43:49.056 SIP.STACK MSG         INVITE sip:4126069785@sip.east.sipregistration.com:5060 SIP/2.0

15:43:49.056 SIP.STACK MSG         From: <sip:sip.east.sipregistration.com:5060;transport=UDP>;tag=4fa37bf8-7f000001-13c4-2ff63-32aab35-2ff63

15:43:49.057 SIP.STACK MSG         To: <sip:4126069785@sip.east.sipregistration.com:5060>

15:43:49.057 SIP.STACK MSG         Call-ID: 4facb2c0-7f000001-13c4-2ff63-6a0e75ce-2ff63@sip.east.sipregistration.com

15:43:49.057 SIP.STACK MSG         CSeq: 1 INVITE

15:43:49.057 SIP.STACK MSG         Via: SIP/2.0/UDP 24.154.126.17:5060;branch=z9hG4bK-2ff63-bb59ba2-38f81ca9

15:43:49.057 SIP.STACK MSG         Max-Forwards: 70

15:43:49.058 SIP.STACK MSG         Supported: 100rel,replaces

15:43:49.058 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

15:43:49.058 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908e_3rd_Gen/R12.3.1.E

15:43:49.058 SIP.STACK MSG         Contact: <sip:24.154.126.17:5060;transport=UDP>

15:43:49.058 SIP.STACK MSG         Content-Type: application/sdp

15:43:49.059 SIP.STACK MSG         Content-Length: 210

15:43:49.059 SIP.STACK MSG    

15:43:49.059 SIP.STACK MSG         v=0

15:43:49.059 SIP.STACK MSG         o=- 1511210628 1 IN IP4 24.154.126.17

15:43:49.059 SIP.STACK MSG         s=-

15:43:49.059 SIP.STACK MSG         c=IN IP4 24.154.126.17

15:43:49.060 SIP.STACK MSG         t=0 0

15:43:49.060 SIP.STACK MSG         m=audio 10128 RTP/AVP 0 101

15:43:49.060 SIP.STACK MSG         a=silenceSupp:off - - - -

15:43:49.060 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

15:43:49.060 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

15:43:49.060 SIP.STACK MSG         a=fmtp:101 0-15

15:43:49.061 SIP.STACK MSG    

15:43:50.061 SIP.STACK MSG SIP stack timer retransmit

15:43:50.062 SIP.STACK MSG     Tx: UDP src=24.154.126.17:5060 dst=198.58.42.157:5060

15:43:50.062 SIP.STACK MSG         INVITE sip:4126069785@sip.east.sipregistration.com:5060 SIP/2.0

15:43:50.062 SIP.STACK MSG         From: <sip:sip.east.sipregistration.com:5060;transport=UDP>;tag=4fa37bf8-7f000001-13c4-2ff63-32aab35-2ff63

15:43:50.062 SIP.STACK MSG         To: <sip:4126069785@sip.east.sipregistration.com:5060>

15:43:50.063 SIP.STACK MSG         Call-ID: 4facb2c0-7f000001-13c4-2ff63-6a0e75ce-2ff63@sip.east.sipregistration.com

15:43:50.063 SIP.STACK MSG         CSeq: 1 INVITE

15:43:50.063 SIP.STACK MSG         Via: SIP/2.0/UDP 24.154.126.17:5060;branch=z9hG4bK-2ff63-bb59ba2-38f81ca9

15:43:50.063 SIP.STACK MSG         Max-Forwards: 70

15:43:50.063 SIP.STACK MSG         Supported: 100rel,replaces

15:43:50.063 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

15:43:50.064 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908e_3rd_Gen/R12.3.1.E

15:43:50.064 SIP.STACK MSG         Contact: <sip:24.154.126.17:5060;transport=UDP>

15:43:50.064 SIP.STACK MSG         Content-Type: application/sdp

15:43:50.064 SIP.STACK MSG         Content-Length: 210

15:43:50.064 SIP.STACK MSG    

15:43:50.065 SIP.STACK MSG         v=0

15:43:50.065 SIP.STACK MSG         o=- 1511210628 1 IN IP4 24.154.126.17

15:43:50.065 SIP.STACK MSG         s=-

15:43:50.065 SIP.STACK MSG         c=IN IP4 24.154.126.17

15:43:50.065 SIP.STACK MSG         t=0 0

15:43:50.066 SIP.STACK MSG         m=audio 10128 RTP/AVP 0 101

15:43:50.066 SIP.STACK MSG         a=silenceSupp:off - - - -

15:43:50.066 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

15:43:50.066 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

15:43:50.066 SIP.STACK MSG         a=fmtp:101 0-15

15:43:50.067 SIP.STACK MSG    

15:43:51.557 TM.T01 55 INVITE rollover timeout

15:43:51.557 TM.T01 55 Delivering           Sip_CreateCallLegNextServer with default validator

15:43:51.558 TM.T01 55 Delivering           State change      >> Delivering->SipTM_Closing

15:43:51.558 TM.T01 55 SipTM_Closing        sent: TA->Clear

15:43:51.558 SIP.CLDU Cldu::CallLegStateChangedEv: (0x0x4facb2c0)->Terminated

15:43:51.559 TM.T01 55 SipTM_Closing        call-leg -> Terminated

15:43:51.559 TA.T01 55 TAOutGoing           rcvd: clear from TM

15:43:51.559 TA.T01 55 State change      >> TAOutGoing->TATrunkClearing (TAS_Clearing)

15:43:51.559 TM.T01 55 SipTM_Closing        tachg -> TATrunkClearing

15:43:51.560 TM.T01 55 SipTM_Closing        State change      >> SipTM_Closing->SipTM_Terminated

15:43:51.560 TM.T01 55 SipTM_Terminated     sent: TA->AppearanceOff

15:43:51.560 TM.T01 55 SipTM_Terminated     State change      >> SipTM_Terminated->SipTM_Idle

15:43:51.561 SB.CALL 65 Delivering           Called the clearCall routine

15:43:51.561 SB.CALL 65 Delivering           SIP Proxy rejected call to 4126069785 for survivability - no matching Proxy user

15:43:51.562 SB.CALL 65 Delivering           No available resources on call from T02 to T01 (last attempt)

15:43:51.562 SB.CALL 65 State change      >> Delivering->Clearing

15:43:51.562 TA.T01 55 TATrunkClearing      rcvd: appearance off from TM

15:43:51.562 TA.T01 55 State change      >> TATrunkClearing->TAClearingComplete (TAS_Clearing)

15:43:51.562 TA.T01 55 TATrunkClearing      Processing an appearance OFF

15:43:51.563 TA.T02 23 TAConnectWaitIn      ClearCall event accepted

15:43:51.563 TA.T02 23 State change      >> TAConnectWaitIn->TAClearingComplete (TAS_Clearing)

15:43:51.563 TM.T02 23 IsdnTmStateInboundAccept->IsdnTmStateUserClearing

15:43:51.563 TM.T02 23 IsdnTmStateUserClearing::enter()

15:43:51.564 ISDN.L2_FMT PRI  1  ==============================================

15:43:51.564 ISDN.L2_FMT PRI  1  T Sapi:00 C/R:C Tei:00 INFO Ns:82  Nr:53  P:0

15:43:51.564 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:8031

15:43:51.564 ISDN.L2_FMT PRI  1    M - 45 DISCONNECT 

15:43:51.564 ISDN.L2_FMT PRI  1     IE - 08 CAUSE               Len=2

15:43:51.564 ISDN.L2_FMT PRI  1          82 Location:LN

15:43:51.565 ISDN.L2_FMT PRI  1          A9 Cause:41 (TEMPORARY_FAILURE)

15:43:51.565 SB.CALL 65 Clearing             Called the clearResponse routine

15:43:51.565 SB.CALL 65 State change      >> Clearing->CallIdlePending

15:43:51.565 SB.CCM release:

15:43:51.565 SB.CCM  :  Call Struct 0x0x502b2010 :   Call-ID = 65

15:43:51.566 SB.CCM  :  Org Acct = T02    Dst Acct = T01

15:43:51.566 SB.CCM  :  Org Port ID = Isdn(Ds1Ds0Trunk) 0/4.23   Dst Port ID = SipTrunk 0/0.54

15:43:51.566 SB.CCM  :  SDP Transaction = CallID: 65

15:43:51.566 SB.CCM  :  SDP Offer = 0x505f8f10, (127.0.0.3:10128)

15:43:51.566 SB.CCM  :  Offer side SRTP session details

15:43:51.567 SB.CCM  :    None

15:43:51.567 SB.CCM  :  Answer side SRTP session details

15:43:51.567 SB.CCM  :    None

15:43:51.567 SB.CCM  :  RTP Channel = 0/1.1

15:43:51.567 SB.CCM release: Call Connection Type is TDM_TO_RTP

15:43:51.568 SB.CCM release: Releasing RTP Channel 0/1.1

15:43:51.568 RTP.CHANNEL RtpChannel::deallocate, status = 3, allocatedForInterface = 0

15:43:51.568 RTP.CHANNEL Channel 0/1.1 released successfully.

15:43:51.569 SB.CALL 65 CallIdlePending      ClearResponse sent from T02 to T01

15:43:51.569 TA.T01 55 TAClearingComplete   clearResponse event accepted

15:43:51.569 TA.T01 55 TAClearingComplete   Clear Local Variables

15:43:51.569 TA.T01 55 State change      >> TAClearingComplete->TAIdle (TAS_Idle)

15:43:51.569 TM.T01 55 SipTM_Idle           tachg -> TAIdle

15:43:51.570 RTP.CHANNEL t1 0/4.23 - Dsp 0/1.1 - RTP: releasing RTP resource

15:43:51.570 RTP.CHANNEL t1 0/4.23 - Dsp 0/1.1 - RTP: releasing

15:43:51 SB.CallStructObserver 65 Finalized

15:43:51.574 ISDN.L2_FMT PRI  1  ==============================================

15:43:51.574 ISDN.L2_FMT PRI  1  R Sapi:00 C/R:R Tei:00 INFO Ns:53  Nr:83  P:0

15:43:51.574 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:0031

15:43:51.574 ISDN.L2_FMT PRI  1    M - 4D RELEASE    

15:43:51.575 ISDN.L2_FMT PRI  1  ==============================================

15:43:51.575 ISDN.L2_FMT PRI  1  T Sapi:00 C/R:C Tei:00 INFO Ns:83  Nr:54  P:0

15:43:51.575 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:8031

15:43:51.575 ISDN.L2_FMT PRI  1    M - 5A RELEASE_CMP

15:43:51.575 TM.T02 23 IsdnTmStateUserClearing->IsdnTmStateIdling

15:43:51.576 TM.T02 23 IsdnTmStateIdling::enter()

15:43:51.576 TM.T02 23 IsdnTmStateIdling - send appearance off

15:43:51.576 TM.T02 23 IsdnTmStateIdling->IsdnTmStateIdle

15:43:51.576 TM.T02 23 IsdnAppearanceChannel::releaseChannel

15:43:51.576 TM.T02 23 IsdnTmStateIdle::enter()

15:43:51.577 TA.T02 23 TAClearingComplete   rcvd: appearance off from TM

15:43:51.577 TA.T02 23 TAClearingComplete   Clear Local Variables

15:43:51.577 TA.T02 23 State change      >> TAClearingComplete->TAIdle (TAS_Idle)2017.11.20 15:43:52 SMDR 65         11/20/2017 15:43:48      0.0 0    I  00/04                                 00/00 T01             4126069785      0 N 

Labels (2)
0 Kudos
1 Solution

Accepted Solutions
jayh
Honored Contributor
Honored Contributor

Re: SIP/PRI No Service In or out

Jump to solution

For incoming calls SIP->PRI, the problem is that the TA900 is trying to match the Request-URI to route the call. This is "sip0000001_xxxx" which is obviously not a phone number. Hence no called-number is sent to the PRI. The destination number seems correct in the To: header. To fix this, add the following line to the SIP trunk T01:

  dial-string source to

For outbound calls PRI->SIP, the SIP messages sent to 198.58.42.157 aren't getting a response. Check for a firewall rule along the path (which could be on your provider's end), an IP routing issue, or something else blocking the messages. Perhaps your provider uses a non-standard port?

View solution in original post

0 Kudos
3 Replies
jayh
Honored Contributor
Honored Contributor

Re: SIP/PRI No Service In or out

Jump to solution

For incoming calls SIP->PRI, the problem is that the TA900 is trying to match the Request-URI to route the call. This is "sip0000001_xxxx" which is obviously not a phone number. Hence no called-number is sent to the PRI. The destination number seems correct in the To: header. To fix this, add the following line to the SIP trunk T01:

  dial-string source to

For outbound calls PRI->SIP, the SIP messages sent to 198.58.42.157 aren't getting a response. Check for a firewall rule along the path (which could be on your provider's end), an IP routing issue, or something else blocking the messages. Perhaps your provider uses a non-standard port?

0 Kudos

Re: SIP/PRI No Service In or out

Jump to solution

Hi jayh,

Your answer corrected my inbound call problem. However, I had to reload the default config and found inbound calls worked without your solution. Something in my original config was AFU. I found that the real issue was that my PBX PRI was not sending Caller ID to the 908e. My SIP server was set to look for the caller ID as part of the authentication process. I have tagged your answer as Correct as it did provide a solution for the problem. Thanks!

jayh
Honored Contributor
Honored Contributor

Re: SIP/PRI No Service In or out

Jump to solution

You can program the TA900 to override what the PBX sends, or to send CLID if the PBX doesn't send it. On the trunk facing the PBX, set:

caller-id-override number-inbound 3112551212

or

caller-id-override number-inbound 3115551212 if-no-cpn

The first will automatically send 311-555-1212 regardless of what the PBX sends.

The second will send 311-555-1212 only if the PBX doesn't send CLID.

You can (and possibly should, depending on circumstance) on the outgoing trunk set a specific CLID for calls to 9-1-1. Syntax:

caller-id-override emergency-outbound 311-555-1212

It's a bit counter-intuitive with the inbound and outbound. They're with respect to the Adtran itself, so inbound is CLID coming from the PBX and outbound is CLID outbound towards the carrier.