3 Replies Latest reply on Nov 27, 2017 9:28 PM by jayh

    SIP/PRI No Service In or out

    tonysprout New Member

      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 

        • Re: SIP/PRI No Service In or out
          jayh Hall_of_Fame

          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?

            • Re: SIP/PRI No Service In or out
              tonysprout New Member

              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!

                • Re: SIP/PRI No Service In or out
                  jayh Hall_of_Fame

                  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.