15:52:15.801 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:15.801 SIP.STACK MSG INVITE sip:16124525510@Customer_IP SIP/2.0 15:52:15.802 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK52e2118d;rport 15:52:15.802 SIP.STACK MSG Max-Forwards: 70 15:52:15.803 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as554ce9b5 15:52:15.804 SIP.STACK MSG To: 15:52:15.804 SIP.STACK MSG Contact: 15:52:15.805 SIP.STACK MSG Call-ID: 25a0fe4356bf076a0706ee7a6d3204da@Carrier_IP:5060 15:52:15.805 SIP.STACK MSG CSeq: 102 INVITE 15:52:15.806 SIP.STACK MSG User-Agent: Prescient PBX 15:52:15.807 SIP.STACK MSG Date: Mon, 22 Feb 2021 20:52:15 GMT 15:52:15.807 SIP.STACK MSG Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH 15:52:15.808 SIP.STACK MSG Supported: replaces, timer 15:52:15.808 SIP.STACK MSG P-Asserted-Identity: "WIRELESS CALLER" 15:52:15.809 SIP.STACK MSG Content-Type: application/sdp 15:52:15.810 SIP.STACK MSG Content-Length: 229 15:52:15.810 SIP.STACK MSG 15:52:15.811 SIP.STACK MSG v=0 15:52:15.811 SIP.STACK MSG o=root 1687594892 1687594892 IN IP4 Carrier_IP 15:52:15.812 SIP.STACK MSG s=Prescient PBX 15:52:15.812 SIP.STACK MSG c=IN IP4 Carrier_IP 15:52:15.813 SIP.STACK MSG t=0 0 15:52:15.813 SIP.STACK MSG m=audio 18758 RTP/AVP 0 101 15:52:15.814 SIP.STACK MSG a=rtpmap:0 PCMU/8000 15:52:15.815 SIP.STACK MSG a=rtpmap:101 telephone-event/8000 15:52:15.815 SIP.STACK MSG a=fmtp:101 0-16 15:52:15.816 SIP.STACK MSG a=ptime:20 15:52:15.816 SIP.STACK MSG a=sendrecv 15:52:15.817 SIP.STACK MSG 15:52:15.825 TM.T03 01 SipTM_Idle rcvd SIP call-leg request: INVITE 15:52:15.826 TM.T03 01 SipTM_Idle call-leg -> Offering 15:52:15.827 TM.T03 01 SipTM_Idle State change >> SipTM_Idle->SipTM_Trying 15:52:15.829 TM.T03 01 SipTM_Trying SDP offer is not loopback request 15:52:15.831 TM.T03 01 SipTM_Trying Ignoring P-Asserted-Identity header. 15:52:15.832 TM.T03 01 SipTM_Trying Processing From for Caller-ID. 15:52:15.832 TM.T03 01 SipTM_Trying Caller ID Name = "WIRELESS CALLER" 15:52:15.833 TM.T03 01 SipTM_Trying Caller ID Number = "18608109257" 15:52:15.834 TM.T03 01 SipTM_Trying info: unable to set redirect number(s) from INVITE 15:52:15.834 TM.T03 01 SipTM_Trying sent: TA->InboundCall 15:52:15.835 TM.T03 01 Looking up source address for destination Carrier_IP 15:52:15.836 TM.T03 01 call-leg (0x2c70a70) -> src: Customer_IP : 5060 dst: Carrier_IP : 5060 15:52:15.839 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:15.840 SIP.STACK MSG SIP/2.0 100 Trying 15:52:15.840 SIP.STACK MSG From: "WIRELESS CALLER";tag=as554ce9b5 15:52:15.841 SIP.STACK MSG To: 15:52:15.841 SIP.STACK MSG Call-ID: 25a0fe4356bf076a0706ee7a6d3204da@Carrier_IP:5060 15:52:15.842 SIP.STACK MSG CSeq: 102 INVITE 15:52:15.843 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK52e2118d 15:52:15.843 SIP.STACK MSG Contact: 15:52:15.844 SIP.STACK MSG Supported: 100rel,replaces 15:52:15.844 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:15.845 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:15.845 SIP.STACK MSG Content-Length: 0 15:52:15.846 SIP.STACK MSG 15:52:15.847 TM.T03 01 SipTM_Trying sent: 100 Trying 15:52:15.848 TA.T03 01 TAIdle rcvd: inboundCall from TM 15:52:15.849 TA.T03 01 State change >> TAIdle->TAInboundCall (TAS_Calling) 15:52:15.849 TA.T03 01 Failed - DID translation: no match for 16124525510, using 16124525510 15:52:15.850 TA.T03 01 TAIdle sent: call to SB 15:52:15.851 TM.T03 01 SipTM_Trying tachg -> TAInboundCall 15:52:15.851 TM.T03 01 SipTM_Trying State change >> SipTM_Trying->SipTM_Pending 15:52:15.852 SB.CALL 104 Idle Called the call routine with 16124525510 15:52:15 SB.TGMgr For dialed number 16124525510, against template $, on TrunkGroup PRI-1, the score is 500 15:52:15 SB.TGMgr For dialed number 16124525510, against template 1-NXX-NXX-XXXX, on TrunkGroup AEON, the score is 2000 15:52:15.854 SB.CCM isMappable: 15:52:15.854 SB.CCM : Call Struct 0x27bec10 : Call-ID = 104 15:52:15.855 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:15.856 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = unknown 0/0 15:52:15.856 SB.CCM : SDP Transaction = CallID: 104 15:52:15.857 SB.CCM : SDP Offer = 0x0277f210, (Carrier_IP:18758) 15:52:15.857 SB.CCM isMappable: Call Connection Type is RTP_TO_TDM 15:52:15.859 SB.CCM isMappable: Reserving RTP Channel 0/1.1 15:52:15.860 SB.CCM translateOffer: offer codec list: PCMU 15:52:15.861 SB.CCM translateOffer: revised offer codec list: PCMU 15:52:15.863 SB.CCM translateOffer: codec list after answerer: PCMU 15:52:15.864 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through 15:52:15.865 SB.CCM translateOffer: success 15:52:15.866 MEDIA.MANAGER Allocating media port. 15:52:15.867 MEDIA.MANAGER getSubstitutePort: No matching callIdMap entry found for call 104 15:52:15.867 MEDIA.MANAGER Call ID map : Added new entry : call ID 104 : session root1687594892INIP4Carrier_IP : version 1687594892 : index 212 15:52:15.869 MEDIA.MANAGER New media entry : type(0), callID(104), sessionID(root1687594892INIP4Carrier_IP), original IP(Carrier_IP) ports(18758-18759), substitute IP(::) ports(10212-10213), RtpChannel(0/1.1), connection(0x277dd10), sdpOverride(0), me(0x2784d10). RtpChannel 0/1.1 15:52:15.869 SB.CALL 104 Idle Call sent from T03 to T01 (16124525510) 15:52:15.870 SB.CALL 104 State change >> Idle->Delivering 15:52:15.870 RTP.MANAGER Isdn(Group) 0/ - empty - RTP: Reserve resource 15:52:15.871 RTP.MANAGER Isdn(Group) 0/ - Dsp 0/1.1 - RTP: (null) 15:52:15.872 RTP.PROVIDER unknown - Dsp 0/1.1 - RTP: reserving already allocated RTP channel 15:52:15.873 TA.T03 01 TAInboundCall CallResp event accepted 15:52:15.873 TA.T03 01 State change >> TAInboundCall->TAConnectWaitIn (TAS_Calling) 15:52:15.874 TA.T01 01 State change >> TAIdle->TAOutGoing (TAS_Delivering) 15:52:15.875 TM.T01 01 tachg_Delivering 15:52:15.875 TA.T01 01 DNIS Substitution: dialed number 16124525510 -> 6124525510 15:52:15.876 TM.T01 01 IsdnTmStateIdle->IsdnTmStateOutboundDeliver 15:52:15.877 TM.T01 01 IsdnTmStateOutboundDeliver::enter() 15:52:15.878 ISDN.L2_FMT PRI 1 ============================================== 15:52:15.878 ISDN.L2_FMT PRI 1 T Sapi:00 C/R:C Tei:00 INFO Ns:125 Nr:114 P:0 15:52:15.878 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:0068 15:52:15.879 ISDN.L2_FMT PRI 1 M - 05 SETUP 15:52:15.879 ISDN.L2_FMT PRI 1 IE - 04 BEARER CAPABILITY Len=3 15:52:15.879 ISDN.L2_FMT PRI 1 80 Xfer Cap.:SPEECH 15:52:15.880 ISDN.L2_FMT PRI 1 90 Xfer Rate:64k 15:52:15.880 ISDN.L2_FMT PRI 1 A2 Layer 1:G.711 U-Law 15:52:15.880 ISDN.L2_FMT PRI 1 IE - 18 CHANNEL ID Len=3 15:52:15.881 ISDN.L2_FMT PRI 1 A1 Primary Rate 15:52:15.881 ISDN.L2_FMT PRI 1 Intfc ID:IMPLICIT 15:52:15.881 ISDN.L2_FMT PRI 1 Pref/Excl:PREFERRED 15:52:15.882 ISDN.L2_FMT PRI 1 D-Chan Indicated:NO 15:52:15.882 ISDN.L2_FMT PRI 1 Chan. Sel:FOLLOWS 15:52:15.882 ISDN.L2_FMT PRI 1 83 Numb/Map:NUMBER 15:52:15.882 ISDN.L2_FMT PRI 1 81 Channel:1 15:52:15.883 ISDN.L2_FMT PRI 1 IE - 6C CALLING PARTY # Len=13 15:52:15.883 ISDN.L2_FMT PRI 1 00 Numb. Type:UNKNOWN 15:52:15.883 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:15.884 ISDN.L2_FMT PRI 1 80 Presentation:ALLOWED 15:52:15.884 ISDN.L2_FMT PRI 1 Screening:USER PROVIDED 15:52:15.884 ISDN.L2_FMT PRI 1 Ph.# 18608109257 15:52:15.885 ISDN.L2_FMT PRI 1 IE - 70 CALLED PARTY # Len=11 15:52:15.885 ISDN.L2_FMT PRI 1 80 Numb. Type:UNKNOWN 15:52:15.886 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:15.886 ISDN.L2_FMT PRI 1 Ph.# 6124525510 15:52:15.887 SB.CALL 104 Delivering Called the deliverResponse routine from Delivering 15:52:15.887 SB.CALL 104 Delivering DeliverResponse(accept) sent from T01 to T03 15:52:15.888 TA.T03 01 TAConnectWaitIn deliverResponse event accepted 15:52:15.888 TA.T03 01 TAConnectWaitIn ERROR! deliverResponse ignored 15:52:15.967 ISDN.L2_FMT PRI 1 ============================================== 15:52:15.967 ISDN.L2_FMT PRI 1 R Sapi:00 C/R:R Tei:00 INFO Ns:114 Nr:126 P:0 15:52:15.967 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:8068 15:52:15.968 ISDN.L2_FMT PRI 1 M - 5A RELEASE_CMP 15:52:15.968 ISDN.L2_FMT PRI 1 IE - 08 CAUSE Len=2 15:52:15.968 ISDN.L2_FMT PRI 1 81 Location:LPN 15:52:15.969 ISDN.L2_FMT PRI 1 95 Cause:21 (CALL_REJECTED) 15:52:15.970 TM.T01 01 IsdnTmStateOutboundDeliver->IsdnTmStateIdling 15:52:15.970 TM.T01 01 IsdnTmStateIdling::enter() 15:52:15.971 TM.T01 01 IsdnTmStateIdling - send appearance off 15:52:15.972 TM.T01 01 IsdnTmStateIdling->IsdnTmStateIdle 15:52:15.972 TM.T01 01 IsdnAppearanceChannel::releaseChannel 15:52:15.973 TM.T01 01 IsdnTmStateIdle::enter() 15:52:15.974 TA.T01 01 TAOutGoing rcvd: clear from TM 15:52:15.975 TA.T01 01 State change >> TAOutGoing->TATrunkClearing (TAS_Clearing) 15:52:15.975 TM.T01 01 IsdnTmStateIdle::tachgClearing - send appearance off 15:52:15.976 TA.T01 01 TATrunkClearing rcvd: appearance off from TM 15:52:15.977 TA.T01 01 State change >> TATrunkClearing->TAClearingComplete (TAS_Clearing) 15:52:15.977 TA.T01 01 TATrunkClearing Processing an appearance OFF 15:52:15.978 SB.CALL 104 Delivering Called the clearCall routine 15:52:15.978 SB.CALL 104 Delivering SIP Proxy rejected call to 16124525510 for survivability - no matching Proxy user 15:52:15.979 SB.CALL 104 Delivering No available resources on call from T03 to T01 (last attempt) 15:52:15.979 SB.CALL 104 State change >> Delivering->Clearing 15:52:15.980 TA.T01 01 TAClearingComplete rcvd: appearance off from TM 15:52:15.980 TA.T01 01 TAClearingComplete Clear Local Variables 15:52:15.981 TA.T01 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:15.982 TA.T03 01 TAConnectWaitIn ClearCall event accepted 15:52:15.982 TA.T03 01 State change >> TAConnectWaitIn->TAClearingComplete (TAS_Clearing) 15:52:15.983 TM.T03 01 SipTM_Pending tachg -> TAClearingComplete 15:52:15.984 TM.T03 01 SipTM_Pending State change >> SipTM_Pending->SipTM_CallFail 15:52:15.986 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:15.987 SIP.STACK MSG SIP/2.0 403 Forbidden 15:52:15.988 SIP.STACK MSG From: "WIRELESS CALLER";tag=as554ce9b5 15:52:15.988 SIP.STACK MSG To: ;tag=2c51100-7f000001-13c4-51f-e161cba9-51f 15:52:15.989 SIP.STACK MSG Call-ID: 25a0fe4356bf076a0706ee7a6d3204da@Carrier_IP:5060 15:52:15.989 SIP.STACK MSG CSeq: 102 INVITE 15:52:15.990 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK52e2118d 15:52:15.991 SIP.STACK MSG Supported: 100rel,replaces 15:52:15.991 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:15.992 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:15.992 SIP.STACK MSG Content-Length: 0 15:52:15.993 SIP.STACK MSG 15:52:15.996 TM.T03 01 SipTM_CallFail call-leg -> Disconnected 15:52:15.997 TM.T03 01 SipTM_CallFail CallLegStateChanged to Disconnected - TM change to closing state. 15:52:15.997 TM.T03 01 SipTM_CallFail State change >> SipTM_CallFail->SipTM_Closing 15:52:15.998 TM.T03 01 SipTM_Closing sent: TA->Clear 15:52:15.998 TM.T03 01 SipTM_CallFail sent: 0 15:52:15.999 TM.T03 01 SipTM_Closing State change >> SipTM_Closing->SipTM_Terminated 15:52:15.999 TM.T03 01 SipTM_Terminated sent: TA->AppearanceOff 15:52:16.000 TM.T03 01 SipTM_Terminated State change >> SipTM_Terminated->SipTM_Idle 15:52:16.001 SB.CALL 104 Clearing Called the clearResponse routine 15:52:16.002 SB.CALL 104 State change >> Clearing->CallIdlePending 15:52:16.002 SB.CCM release: 15:52:16.003 SB.CCM : Call Struct 0x27bec10 : Call-ID = 104 15:52:16.003 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:16.004 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = Isdn(Group) 0/0 15:52:16.005 SB.CCM : SDP Transaction = CallID: 104 15:52:16.005 SB.CCM : SDP Offer = 0x0277f210, (Carrier_IP:18758) 15:52:16.006 SB.CCM : RTP Channel = 0/1.1 15:52:16.006 SB.CCM release: Call Connection Type is RTP_TO_TDM 15:52:16.007 SB.CCM release: Releasing RTP Channel 0/1.1 15:52:16.008 RTP.CHANNEL Channel 0/1.1 released successfully. 15:52:16.008 SB.CALL 104 CallIdlePending ClearResponse sent from T03 to T01 15:52:16.009 TA.T03 01 TAClearingComplete rcvd: clear from TM 15:52:16.009 TA.T03 01 TAClearingComplete rcvd: appearance off from TM 15:52:16.010 TA.T03 01 TAClearingComplete Clear Local Variables 15:52:16.010 TA.T03 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:16.011 TM.T03 01 SipTM_Idle tachg -> TAIdle 15:52:16.012 TA.T01 clearResponse event rejected, no matching CallID104 15:52:16.012 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing RTP resource 15:52:16.013 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing 2021.02.22 15:52:15 TM.T01 01 IsdnTmStateOutboundDeliver - rcvd unexpected CallRelease 2021.02.22 15:52:15 TM.T01 01 IsdnTmStateIdling - clear trunk appearance 15:52:16.033 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:16.034 SIP.STACK MSG ACK sip:16124525510@Customer_IP SIP/2.0 15:52:16.034 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK52e2118d;rport 15:52:16.035 SIP.STACK MSG Max-Forwards: 70 15:52:16.035 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as554ce9b5 15:52:16.036 SIP.STACK MSG To: ;tag=2c51100-7f000001-13c4-51f-e161cba9-51f 15:52:16.037 SIP.STACK MSG Contact: 15:52:16.037 SIP.STACK MSG Call-ID: 25a0fe4356bf076a0706ee7a6d3204da@Carrier_IP:5060 15:52:16.038 SIP.STACK MSG CSeq: 102 ACK 15:52:16.039 SIP.STACK MSG User-Agent: Prescient PBX 15:52:16.039 SIP.STACK MSG Content-Length: 0 15:52:16.040 SIP.STACK MSG 15:52:16.319 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:16.320 SIP.STACK MSG INVITE sip:16124525510@Customer_IP SIP/2.0 15:52:16.321 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK12ca00c0;rport 15:52:16.321 SIP.STACK MSG Max-Forwards: 70 15:52:16.322 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as6399babb 15:52:16.322 SIP.STACK MSG To: 15:52:16.323 SIP.STACK MSG Contact: 15:52:16.323 SIP.STACK MSG Call-ID: 1d98b4122c2218a414e4c11163840b3d@Carrier_IP:5060 15:52:16.324 SIP.STACK MSG CSeq: 102 INVITE 15:52:16.324 SIP.STACK MSG User-Agent: Prescient PBX 15:52:16.325 SIP.STACK MSG Date: Mon, 22 Feb 2021 20:52:16 GMT 15:52:16.326 SIP.STACK MSG Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH 15:52:16.326 SIP.STACK MSG Supported: replaces, timer 15:52:16.327 SIP.STACK MSG P-Asserted-Identity: "WIRELESS CALLER" 15:52:16.328 SIP.STACK MSG Content-Type: application/sdp 15:52:16.328 SIP.STACK MSG Content-Length: 227 15:52:16.329 SIP.STACK MSG 15:52:16.329 SIP.STACK MSG v=0 15:52:16.330 SIP.STACK MSG o=root 910614975 910614975 IN IP4 Carrier_IP 15:52:16.330 SIP.STACK MSG s=Prescient PBX 15:52:16.331 SIP.STACK MSG c=IN IP4 Carrier_IP 15:52:16.332 SIP.STACK MSG t=0 0 15:52:16.332 SIP.STACK MSG m=audio 13254 RTP/AVP 0 101 15:52:16.333 SIP.STACK MSG a=rtpmap:0 PCMU/8000 15:52:16.333 SIP.STACK MSG a=rtpmap:101 telephone-event/8000 15:52:16.334 SIP.STACK MSG a=fmtp:101 0-16 15:52:16.334 SIP.STACK MSG a=ptime:20 15:52:16.335 SIP.STACK MSG a=sendrecv 15:52:16.335 SIP.STACK MSG 15:52:16.344 TM.T03 01 SipTM_Idle rcvd SIP call-leg request: INVITE 15:52:16.345 TM.T03 01 SipTM_Idle call-leg -> Offering 15:52:16.346 TM.T03 01 SipTM_Idle State change >> SipTM_Idle->SipTM_Trying 15:52:16.347 TM.T03 01 SipTM_Trying SDP offer is not loopback request 15:52:16.350 TM.T03 01 SipTM_Trying Ignoring P-Asserted-Identity header. 15:52:16.350 TM.T03 01 SipTM_Trying Processing From for Caller-ID. 15:52:16.351 TM.T03 01 SipTM_Trying Caller ID Name = "WIRELESS CALLER" 15:52:16.352 TM.T03 01 SipTM_Trying Caller ID Number = "18608109257" 15:52:16.352 TM.T03 01 SipTM_Trying info: unable to set redirect number(s) from INVITE 15:52:16.353 TM.T03 01 SipTM_Trying sent: TA->InboundCall 15:52:16.354 TM.T03 01 Looking up source address for destination Carrier_IP 15:52:16.355 TM.T03 01 call-leg (0x2c70ca0) -> src: Customer_IP : 5060 dst: Carrier_IP : 5060 15:52:16.357 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:16.358 SIP.STACK MSG SIP/2.0 100 Trying 15:52:16.359 SIP.STACK MSG From: "WIRELESS CALLER";tag=as6399babb 15:52:16.359 SIP.STACK MSG To: 15:52:16.360 SIP.STACK MSG Call-ID: 1d98b4122c2218a414e4c11163840b3d@Carrier_IP:5060 15:52:16.361 SIP.STACK MSG CSeq: 102 INVITE 15:52:16.361 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK12ca00c0 15:52:16.362 SIP.STACK MSG Contact: 15:52:16.362 SIP.STACK MSG Supported: 100rel,replaces 15:52:16.363 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:16.363 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:16.364 SIP.STACK MSG Content-Length: 0 15:52:16.364 SIP.STACK MSG 15:52:16.366 TM.T03 01 SipTM_Trying sent: 100 Trying 15:52:16.369 TA.T03 01 TAIdle rcvd: inboundCall from TM 15:52:16.370 TA.T03 01 State change >> TAIdle->TAInboundCall (TAS_Calling) 15:52:16.371 TA.T03 01 Failed - DID translation: no match for 16124525510, using 16124525510 15:52:16.371 TA.T03 01 TAIdle sent: call to SB 15:52:16.372 TM.T03 01 SipTM_Trying tachg -> TAInboundCall 15:52:16.373 TM.T03 01 SipTM_Trying State change >> SipTM_Trying->SipTM_Pending 15:52:16.373 SB.CALL 105 Idle Called the call routine with 16124525510 15:52:16 SB.TGMgr For dialed number 16124525510, against template $, on TrunkGroup PRI-1, the score is 500 15:52:16 SB.TGMgr For dialed number 16124525510, against template 1-NXX-NXX-XXXX, on TrunkGroup AEON, the score is 2000 15:52:16.375 SB.CCM isMappable: 15:52:16.376 SB.CCM : Call Struct 0x2780010 : Call-ID = 105 15:52:16.376 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:16.377 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = unknown 0/0 15:52:16.377 SB.CCM : SDP Transaction = CallID: 105 15:52:16.378 SB.CCM : SDP Offer = 0x0277f110, (Carrier_IP:13254) 15:52:16.379 SB.CCM isMappable: Call Connection Type is RTP_TO_TDM 15:52:16.380 SB.CCM isMappable: Reserving RTP Channel 0/1.1 15:52:16.382 SB.CCM translateOffer: offer codec list: PCMU 15:52:16.383 SB.CCM translateOffer: revised offer codec list: PCMU 15:52:16.384 SB.CCM translateOffer: codec list after answerer: PCMU 15:52:16.385 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through 15:52:16.386 SB.CCM translateOffer: success 15:52:16.387 MEDIA.MANAGER Allocating media port. 15:52:16.388 MEDIA.MANAGER getSubstitutePort: No matching callIdMap entry found for call 105 15:52:16.389 MEDIA.MANAGER Call ID map : Added new entry : call ID 105 : session root910614975INIP4Carrier_IP : version 910614975 : index 214 15:52:16.390 MEDIA.MANAGER New media entry : type(0), callID(105), sessionID(root910614975INIP4Carrier_IP), original IP(Carrier_IP) ports(13254-13255), substitute IP(::) ports(10214-10215), RtpChannel(0/1.1), connection(0x27c1410), sdpOverride(0), me(0x2784d10). RtpChannel 0/1.1 15:52:16.391 SB.CALL 105 Idle Call sent from T03 to T01 (16124525510) 15:52:16.391 SB.CALL 105 State change >> Idle->Delivering 15:52:16.392 RTP.MANAGER Isdn(Group) 0/ - empty - RTP: Reserve resource 15:52:16.393 RTP.MANAGER Isdn(Group) 0/ - Dsp 0/1.1 - RTP: (null) 15:52:16.393 RTP.PROVIDER unknown - Dsp 0/1.1 - RTP: reserving already allocated RTP channel 15:52:16.394 TA.T03 01 TAInboundCall CallResp event accepted 15:52:16.395 TA.T03 01 State change >> TAInboundCall->TAConnectWaitIn (TAS_Calling) 15:52:16.395 TA.T01 01 State change >> TAIdle->TAOutGoing (TAS_Delivering) 15:52:16.396 TM.T01 01 tachg_Delivering 15:52:16.397 TA.T01 01 DNIS Substitution: dialed number 16124525510 -> 6124525510 15:52:16.397 TM.T01 01 IsdnTmStateIdle->IsdnTmStateOutboundDeliver 15:52:16.398 TM.T01 01 IsdnTmStateOutboundDeliver::enter() 15:52:16.399 ISDN.L2_FMT PRI 1 ============================================== 15:52:16.400 ISDN.L2_FMT PRI 1 T Sapi:00 C/R:C Tei:00 INFO Ns:126 Nr:115 P:0 15:52:16.400 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:0069 15:52:16.400 ISDN.L2_FMT PRI 1 M - 05 SETUP 15:52:16.400 ISDN.L2_FMT PRI 1 IE - 04 BEARER CAPABILITY Len=3 15:52:16.401 ISDN.L2_FMT PRI 1 80 Xfer Cap.:SPEECH 15:52:16.401 ISDN.L2_FMT PRI 1 90 Xfer Rate:64k 15:52:16.402 ISDN.L2_FMT PRI 1 A2 Layer 1:G.711 U-Law 15:52:16.402 ISDN.L2_FMT PRI 1 IE - 18 CHANNEL ID Len=3 15:52:16.402 ISDN.L2_FMT PRI 1 A1 Primary Rate 15:52:16.403 ISDN.L2_FMT PRI 1 Intfc ID:IMPLICIT 15:52:16.403 ISDN.L2_FMT PRI 1 Pref/Excl:PREFERRED 15:52:16.403 ISDN.L2_FMT PRI 1 D-Chan Indicated:NO 15:52:16.404 ISDN.L2_FMT PRI 1 Chan. Sel:FOLLOWS 15:52:16.404 ISDN.L2_FMT PRI 1 83 Numb/Map:NUMBER 15:52:16.404 ISDN.L2_FMT PRI 1 81 Channel:1 15:52:16.404 ISDN.L2_FMT PRI 1 IE - 6C CALLING PARTY # Len=13 15:52:16.405 ISDN.L2_FMT PRI 1 00 Numb. Type:UNKNOWN 15:52:16.405 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:16.405 ISDN.L2_FMT PRI 1 80 Presentation:ALLOWED 15:52:16.406 ISDN.L2_FMT PRI 1 Screening:USER PROVIDED 15:52:16.406 ISDN.L2_FMT PRI 1 Ph.# 18608109257 15:52:16.406 ISDN.L2_FMT PRI 1 IE - 70 CALLED PARTY # Len=11 15:52:16.407 ISDN.L2_FMT PRI 1 80 Numb. Type:UNKNOWN 15:52:16.407 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:16.407 ISDN.L2_FMT PRI 1 Ph.# 6124525510 15:52:16.408 SB.CALL 105 Delivering Called the deliverResponse routine from Delivering 15:52:16.409 SB.CALL 105 Delivering DeliverResponse(accept) sent from T01 to T03 15:52:16.409 TA.T03 01 TAConnectWaitIn deliverResponse event accepted 15:52:16.410 TA.T03 01 TAConnectWaitIn ERROR! deliverResponse ignored 15:52:16.496 ISDN.L2_FMT PRI 1 ============================================== 15:52:16.496 ISDN.L2_FMT PRI 1 R Sapi:00 C/R:R Tei:00 INFO Ns:115 Nr:127 P:0 15:52:16.496 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:8069 15:52:16.497 ISDN.L2_FMT PRI 1 M - 5A RELEASE_CMP 15:52:16.497 ISDN.L2_FMT PRI 1 IE - 08 CAUSE Len=2 15:52:16.497 ISDN.L2_FMT PRI 1 81 Location:LPN 15:52:16.498 ISDN.L2_FMT PRI 1 95 Cause:21 (CALL_REJECTED) 15:52:16.499 TM.T01 01 IsdnTmStateOutboundDeliver->IsdnTmStateIdling 15:52:16.499 TM.T01 01 IsdnTmStateIdling::enter() 15:52:16.500 TM.T01 01 IsdnTmStateIdling - send appearance off 15:52:16.500 TM.T01 01 IsdnTmStateIdling->IsdnTmStateIdle 15:52:16.501 TM.T01 01 IsdnAppearanceChannel::releaseChannel 15:52:16.501 TM.T01 01 IsdnTmStateIdle::enter() 15:52:16.502 TA.T01 01 TAOutGoing rcvd: clear from TM 15:52:16.503 TA.T01 01 State change >> TAOutGoing->TATrunkClearing (TAS_Clearing) 15:52:16.503 TM.T01 01 IsdnTmStateIdle::tachgClearing - send appearance off 15:52:16.504 TA.T01 01 TATrunkClearing rcvd: appearance off from TM 15:52:16.505 TA.T01 01 State change >> TATrunkClearing->TAClearingComplete (TAS_Clearing) 15:52:16.505 TA.T01 01 TATrunkClearing Processing an appearance OFF 15:52:16.506 SB.CALL 105 Delivering Called the clearCall routine 15:52:16.506 SB.CALL 105 Delivering SIP Proxy rejected call to 16124525510 for survivability - no matching Proxy user 15:52:16.507 SB.CALL 105 Delivering No available resources on call from T03 to T01 (last attempt) 15:52:16.508 SB.CALL 105 State change >> Delivering->Clearing 15:52:16.508 TA.T01 01 TAClearingComplete rcvd: appearance off from TM 15:52:16.509 TA.T01 01 TAClearingComplete Clear Local Variables 15:52:16.509 TA.T01 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:16.510 TA.T03 01 TAConnectWaitIn ClearCall event accepted 15:52:16.511 TA.T03 01 State change >> TAConnectWaitIn->TAClearingComplete (TAS_Clearing) 15:52:16.511 TM.T03 01 SipTM_Pending tachg -> TAClearingComplete 15:52:16.512 TM.T03 01 SipTM_Pending State change >> SipTM_Pending->SipTM_CallFail 15:52:16.514 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:16.515 SIP.STACK MSG SIP/2.0 403 Forbidden 15:52:16.516 SIP.STACK MSG From: "WIRELESS CALLER";tag=as6399babb 15:52:16.516 SIP.STACK MSG To: ;tag=2c51308-7f000001-13c4-51f-9ad6dc17-51f 15:52:16.517 SIP.STACK MSG Call-ID: 1d98b4122c2218a414e4c11163840b3d@Carrier_IP:5060 15:52:16.518 SIP.STACK MSG CSeq: 102 INVITE 15:52:16.518 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK12ca00c0 15:52:16.519 SIP.STACK MSG Supported: 100rel,replaces 15:52:16.519 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:16.520 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:16.520 SIP.STACK MSG Content-Length: 0 15:52:16.521 SIP.STACK MSG 15:52:16.524 TM.T03 01 SipTM_CallFail call-leg -> Disconnected 15:52:16.524 TM.T03 01 SipTM_CallFail CallLegStateChanged to Disconnected - TM change to closing state. 15:52:16.525 TM.T03 01 SipTM_CallFail State change >> SipTM_CallFail->SipTM_Closing 15:52:16.526 TM.T03 01 SipTM_Closing sent: TA->Clear 15:52:16.526 TM.T03 01 SipTM_CallFail sent: 0 15:52:16.527 TM.T03 01 SipTM_Closing State change >> SipTM_Closing->SipTM_Terminated 15:52:16.527 TM.T03 01 SipTM_Terminated sent: TA->AppearanceOff 15:52:16.528 TM.T03 01 SipTM_Terminated State change >> SipTM_Terminated->SipTM_Idle 15:52:16.529 SB.CALL 105 Clearing Called the clearResponse routine 15:52:16.530 SB.CALL 105 State change >> Clearing->CallIdlePending 15:52:16.530 SB.CCM release: 15:52:16.531 SB.CCM : Call Struct 0x2780010 : Call-ID = 105 15:52:16.531 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:16.532 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = Isdn(Group) 0/0 15:52:16.532 SB.CCM : SDP Transaction = CallID: 105 15:52:16.533 SB.CCM : SDP Offer = 0x0277f110, (Carrier_IP:13254) 15:52:16.534 SB.CCM : RTP Channel = 0/1.1 15:52:16.534 SB.CCM release: Call Connection Type is RTP_TO_TDM 15:52:16.535 SB.CCM release: Releasing RTP Channel 0/1.1 15:52:16.535 RTP.CHANNEL Channel 0/1.1 released successfully. 15:52:16.536 SB.CALL 105 CallIdlePending ClearResponse sent from T03 to T01 15:52:16.537 TA.T03 01 TAClearingComplete rcvd: clear from TM 15:52:16.537 TA.T03 01 TAClearingComplete rcvd: appearance off from TM 15:52:16.538 TA.T03 01 TAClearingComplete Clear Local Variables 15:52:16.539 TA.T03 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:16.539 TM.T03 01 SipTM_Idle tachg -> TAIdle 15:52:16.540 TA.T01 clearResponse event rejected, no matching CallID105 15:52:16.541 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing RTP resource 15:52:16.541 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing 2021.02.22 15:52:16 TM.T01 01 IsdnTmStateOutboundDeliver - rcvd unexpected CallRelease 2021.02.22 15:52:16 TM.T01 01 IsdnTmStateIdling - clear trunk appearance 15:52:16.561 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:16.562 SIP.STACK MSG ACK sip:16124525510@Customer_IP SIP/2.0 15:52:16.562 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK12ca00c0;rport 15:52:16.563 SIP.STACK MSG Max-Forwards: 70 15:52:16.563 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as6399babb 15:52:16.564 SIP.STACK MSG To: ;tag=2c51308-7f000001-13c4-51f-9ad6dc17-51f 15:52:16.565 SIP.STACK MSG Contact: 15:52:16.565 SIP.STACK MSG Call-ID: 1d98b4122c2218a414e4c11163840b3d@Carrier_IP:5060 15:52:16.566 SIP.STACK MSG CSeq: 102 ACK 15:52:16.566 SIP.STACK MSG User-Agent: Prescient PBX 15:52:16.567 SIP.STACK MSG Content-Length: 0 15:52:16.567 SIP.STACK MSG 2021.02.22 15:52:17 SMDR 104 02/22/2021 15:52:15 0.0 0 E 00/00 WIRELESS CALLER 18608109257 00/00 T01 16124525510 0 N 2021.02.22 15:52:17 SMDR 105 02/22/2021 15:52:16 0.0 0 E 00/00 WIRELESS CALLER 18608109257 00/00 T01 16124525510 0 N 15:52:17.833 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:17.834 SIP.STACK MSG INVITE sip:16124525510@Customer_IP SIP/2.0 15:52:17.834 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK22b3a472;rport 15:52:17.835 SIP.STACK MSG Max-Forwards: 70 15:52:17.835 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as79ff9be5 15:52:17.836 SIP.STACK MSG To: 15:52:17.836 SIP.STACK MSG Contact: 15:52:17.837 SIP.STACK MSG Call-ID: 5d39511c6dea63d06565d66f7376784e@Carrier_IP:5060 15:52:17.838 SIP.STACK MSG CSeq: 102 INVITE 15:52:17.838 SIP.STACK MSG User-Agent: Prescient PBX 15:52:17.839 SIP.STACK MSG Date: Mon, 22 Feb 2021 20:52:17 GMT 15:52:17.839 SIP.STACK MSG Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH 15:52:17.840 SIP.STACK MSG Supported: replaces, timer 15:52:17.841 SIP.STACK MSG P-Asserted-Identity: "WIRELESS CALLER" 15:52:17.841 SIP.STACK MSG Content-Type: application/sdp 15:52:17.842 SIP.STACK MSG Content-Length: 227 15:52:17.842 SIP.STACK MSG 15:52:17.843 SIP.STACK MSG v=0 15:52:17.843 SIP.STACK MSG o=root 645221411 645221411 IN IP4 Carrier_IP 15:52:17.844 SIP.STACK MSG s=Prescient PBX 15:52:17.845 SIP.STACK MSG c=IN IP4 Carrier_IP 15:52:17.845 SIP.STACK MSG t=0 0 15:52:17.846 SIP.STACK MSG m=audio 15780 RTP/AVP 0 101 15:52:17.846 SIP.STACK MSG a=rtpmap:0 PCMU/8000 15:52:17.847 SIP.STACK MSG a=rtpmap:101 telephone-event/8000 15:52:17.847 SIP.STACK MSG a=fmtp:101 0-16 15:52:17.848 SIP.STACK MSG a=ptime:20 15:52:17.849 SIP.STACK MSG a=sendrecv 15:52:17.849 SIP.STACK MSG 15:52:17.858 TM.T03 01 SipTM_Idle rcvd SIP call-leg request: INVITE 15:52:17.859 TM.T03 01 SipTM_Idle call-leg -> Offering 15:52:17.860 TM.T03 01 SipTM_Idle State change >> SipTM_Idle->SipTM_Trying 15:52:17.861 TM.T03 01 SipTM_Trying SDP offer is not loopback request 15:52:17.864 TM.T03 01 SipTM_Trying Ignoring P-Asserted-Identity header. 15:52:17.864 TM.T03 01 SipTM_Trying Processing From for Caller-ID. 15:52:17.865 TM.T03 01 SipTM_Trying Caller ID Name = "WIRELESS CALLER" 15:52:17.866 TM.T03 01 SipTM_Trying Caller ID Number = "18608109257" 15:52:17.866 TM.T03 01 SipTM_Trying info: unable to set redirect number(s) from INVITE 15:52:17.867 TM.T03 01 SipTM_Trying sent: TA->InboundCall 15:52:17.868 TM.T03 01 Looking up source address for destination Carrier_IP 15:52:17.869 TM.T03 01 call-leg (0x2c70ed0) -> src: Customer_IP : 5060 dst: Carrier_IP : 5060 15:52:17.871 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:17.872 SIP.STACK MSG SIP/2.0 100 Trying 15:52:17.873 SIP.STACK MSG From: "WIRELESS CALLER";tag=as79ff9be5 15:52:17.874 SIP.STACK MSG To: 15:52:17.874 SIP.STACK MSG Call-ID: 5d39511c6dea63d06565d66f7376784e@Carrier_IP:5060 15:52:17.875 SIP.STACK MSG CSeq: 102 INVITE 15:52:17.875 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK22b3a472 15:52:17.876 SIP.STACK MSG Contact: 15:52:17.876 SIP.STACK MSG Supported: 100rel,replaces 15:52:17.877 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:17.878 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:17.878 SIP.STACK MSG Content-Length: 0 15:52:17.879 SIP.STACK MSG 15:52:17.880 TM.T03 01 SipTM_Trying sent: 100 Trying 15:52:17.881 TA.T03 01 TAIdle rcvd: inboundCall from TM 15:52:17.881 TA.T03 01 State change >> TAIdle->TAInboundCall (TAS_Calling) 15:52:17.882 TA.T03 01 Failed - DID translation: no match for 16124525510, using 16124525510 15:52:17.883 TA.T03 01 TAIdle sent: call to SB 15:52:17.883 TM.T03 01 SipTM_Trying tachg -> TAInboundCall 15:52:17.884 TM.T03 01 SipTM_Trying State change >> SipTM_Trying->SipTM_Pending 15:52:17.885 SB.CALL 106 Idle Called the call routine with 16124525510 15:52:17 SB.TGMgr For dialed number 16124525510, against template $, on TrunkGroup PRI-1, the score is 500 15:52:17 SB.TGMgr For dialed number 16124525510, against template 1-NXX-NXX-XXXX, on TrunkGroup AEON, the score is 2000 15:52:17.887 SB.CCM isMappable: 15:52:17.887 SB.CCM : Call Struct 0x2780010 : Call-ID = 106 15:52:17.888 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:17.888 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = unknown 0/0 15:52:17.889 SB.CCM : SDP Transaction = CallID: 106 15:52:17.890 SB.CCM : SDP Offer = 0x02783010, (Carrier_IP:15780) 15:52:17.890 SB.CCM isMappable: Call Connection Type is RTP_TO_TDM 15:52:17.891 SB.CCM isMappable: Reserving RTP Channel 0/1.1 15:52:17.893 SB.CCM translateOffer: offer codec list: PCMU 15:52:17.894 SB.CCM translateOffer: revised offer codec list: PCMU 15:52:17.896 SB.CCM translateOffer: codec list after answerer: PCMU 15:52:17.897 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through 15:52:17.898 SB.CCM translateOffer: success 15:52:17.899 MEDIA.MANAGER Allocating media port. 15:52:17.899 MEDIA.MANAGER getSubstitutePort: No matching callIdMap entry found for call 106 15:52:17.900 MEDIA.MANAGER Call ID map : Added new entry : call ID 106 : session root645221411INIP4Carrier_IP : version 645221411 : index 216 15:52:17.901 MEDIA.MANAGER New media entry : type(0), callID(106), sessionID(root645221411INIP4Carrier_IP), original IP(Carrier_IP) ports(15780-15781), substitute IP(::) ports(10216-10217), RtpChannel(0/1.1), connection(0x27c5810), sdpOverride(0), me(0x277f110). RtpChannel 0/1.1 15:52:17.902 SB.CALL 106 Idle Call sent from T03 to T01 (16124525510) 15:52:17.903 SB.CALL 106 State change >> Idle->Delivering 15:52:17.903 RTP.MANAGER Isdn(Group) 0/ - empty - RTP: Reserve resource 15:52:17.904 RTP.MANAGER Isdn(Group) 0/ - Dsp 0/1.1 - RTP: (null) 15:52:17.905 RTP.PROVIDER unknown - Dsp 0/1.1 - RTP: reserving already allocated RTP channel 15:52:17.905 TA.T03 01 TAInboundCall CallResp event accepted 15:52:17.906 TA.T03 01 State change >> TAInboundCall->TAConnectWaitIn (TAS_Calling) 15:52:17.907 TA.T01 01 State change >> TAIdle->TAOutGoing (TAS_Delivering) 15:52:17.907 TM.T01 01 tachg_Delivering 15:52:17.908 TA.T01 01 DNIS Substitution: dialed number 16124525510 -> 6124525510 15:52:17.909 TM.T01 01 IsdnTmStateIdle->IsdnTmStateOutboundDeliver 15:52:17.909 TM.T01 01 IsdnTmStateOutboundDeliver::enter() 15:52:17.910 ISDN.L2_FMT PRI 1 ============================================== 15:52:17.911 ISDN.L2_FMT PRI 1 T Sapi:00 C/R:C Tei:00 INFO Ns:127 Nr:116 P:0 15:52:17.911 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:006A 15:52:17.912 ISDN.L2_FMT PRI 1 M - 05 SETUP 15:52:17.912 ISDN.L2_FMT PRI 1 IE - 04 BEARER CAPABILITY Len=3 15:52:17.912 ISDN.L2_FMT PRI 1 80 Xfer Cap.:SPEECH 15:52:17.912 ISDN.L2_FMT PRI 1 90 Xfer Rate:64k 15:52:17.913 ISDN.L2_FMT PRI 1 A2 Layer 1:G.711 U-Law 15:52:17.913 ISDN.L2_FMT PRI 1 IE - 18 CHANNEL ID Len=3 15:52:17.913 ISDN.L2_FMT PRI 1 A1 Primary Rate 15:52:17.914 ISDN.L2_FMT PRI 1 Intfc ID:IMPLICIT 15:52:17.914 ISDN.L2_FMT PRI 1 Pref/Excl:PREFERRED 15:52:17.914 ISDN.L2_FMT PRI 1 D-Chan Indicated:NO 15:52:17.915 ISDN.L2_FMT PRI 1 Chan. Sel:FOLLOWS 15:52:17.915 ISDN.L2_FMT PRI 1 83 Numb/Map:NUMBER 15:52:17.915 ISDN.L2_FMT PRI 1 81 Channel:1 15:52:17.916 ISDN.L2_FMT PRI 1 IE - 6C CALLING PARTY # Len=13 15:52:17.916 ISDN.L2_FMT PRI 1 00 Numb. Type:UNKNOWN 15:52:17.916 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:17.917 ISDN.L2_FMT PRI 1 80 Presentation:ALLOWED 15:52:17.917 ISDN.L2_FMT PRI 1 Screening:USER PROVIDED 15:52:17.917 ISDN.L2_FMT PRI 1 Ph.# 18608109257 15:52:17.918 ISDN.L2_FMT PRI 1 IE - 70 CALLED PARTY # Len=11 15:52:17.918 ISDN.L2_FMT PRI 1 80 Numb. Type:UNKNOWN 15:52:17.918 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:17.919 ISDN.L2_FMT PRI 1 Ph.# 6124525510 15:52:17.919 SB.CALL 106 Delivering Called the deliverResponse routine from Delivering 15:52:17.920 SB.CALL 106 Delivering DeliverResponse(accept) sent from T01 to T03 15:52:17.920 TA.T03 01 TAConnectWaitIn deliverResponse event accepted 15:52:17.921 TA.T03 01 TAConnectWaitIn ERROR! deliverResponse ignored 15:52:17.997 ISDN.L2_FMT PRI 1 ============================================== 15:52:17.998 ISDN.L2_FMT PRI 1 R Sapi:00 C/R:R Tei:00 INFO Ns:116 Nr:0 P:0 15:52:17.998 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:806A 15:52:17.998 ISDN.L2_FMT PRI 1 M - 5A RELEASE_CMP 15:52:17.999 ISDN.L2_FMT PRI 1 IE - 08 CAUSE Len=2 15:52:17.999 ISDN.L2_FMT PRI 1 81 Location:LPN 15:52:17.999 ISDN.L2_FMT PRI 1 95 Cause:21 (CALL_REJECTED) 15:52:18.001 TM.T01 01 IsdnTmStateOutboundDeliver->IsdnTmStateIdling 15:52:18.001 TM.T01 01 IsdnTmStateIdling::enter() 15:52:18.002 TM.T01 01 IsdnTmStateIdling - send appearance off 15:52:18.002 TM.T01 01 IsdnTmStateIdling->IsdnTmStateIdle 15:52:18.003 TM.T01 01 IsdnAppearanceChannel::releaseChannel 15:52:18.003 TM.T01 01 IsdnTmStateIdle::enter() 15:52:18.004 TA.T01 01 TAOutGoing rcvd: clear from TM 15:52:18.005 TA.T01 01 State change >> TAOutGoing->TATrunkClearing (TAS_Clearing) 15:52:18.005 TM.T01 01 IsdnTmStateIdle::tachgClearing - send appearance off 15:52:18.006 TA.T01 01 TATrunkClearing rcvd: appearance off from TM 15:52:18.007 TA.T01 01 State change >> TATrunkClearing->TAClearingComplete (TAS_Clearing) 15:52:18.007 TA.T01 01 TATrunkClearing Processing an appearance OFF 15:52:18.008 SB.CALL 106 Delivering Called the clearCall routine 15:52:18.009 SB.CALL 106 Delivering SIP Proxy rejected call to 16124525510 for survivability - no matching Proxy user 15:52:18.009 SB.CALL 106 Delivering No available resources on call from T03 to T01 (last attempt) 15:52:18.010 SB.CALL 106 State change >> Delivering->Clearing 15:52:18.010 TA.T01 01 TAClearingComplete rcvd: appearance off from TM 15:52:18.011 TA.T01 01 TAClearingComplete Clear Local Variables 15:52:18.012 TA.T01 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:18.012 TA.T03 01 TAConnectWaitIn ClearCall event accepted 15:52:18.013 TA.T03 01 State change >> TAConnectWaitIn->TAClearingComplete (TAS_Clearing) 15:52:18.013 TM.T03 01 SipTM_Pending tachg -> TAClearingComplete 15:52:18.014 TM.T03 01 SipTM_Pending State change >> SipTM_Pending->SipTM_CallFail 15:52:18.017 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:18.017 SIP.STACK MSG SIP/2.0 403 Forbidden 15:52:18.018 SIP.STACK MSG From: "WIRELESS CALLER";tag=as79ff9be5 15:52:18.018 SIP.STACK MSG To: ;tag=2c51510-7f000001-13c4-521-e744ea95-521 15:52:18.019 SIP.STACK MSG Call-ID: 5d39511c6dea63d06565d66f7376784e@Carrier_IP:5060 15:52:18.020 SIP.STACK MSG CSeq: 102 INVITE 15:52:18.020 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK22b3a472 15:52:18.021 SIP.STACK MSG Supported: 100rel,replaces 15:52:18.021 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:18.022 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:18.023 SIP.STACK MSG Content-Length: 0 15:52:18.023 SIP.STACK MSG 15:52:18.026 TM.T03 01 SipTM_CallFail call-leg -> Disconnected 15:52:18.027 TM.T03 01 SipTM_CallFail CallLegStateChanged to Disconnected - TM change to closing state. 15:52:18.027 TM.T03 01 SipTM_CallFail State change >> SipTM_CallFail->SipTM_Closing 15:52:18.028 TM.T03 01 SipTM_Closing sent: TA->Clear 15:52:18.029 TM.T03 01 SipTM_CallFail sent: 0 15:52:18.029 TM.T03 01 SipTM_Closing State change >> SipTM_Closing->SipTM_Terminated 15:52:18.030 TM.T03 01 SipTM_Terminated sent: TA->AppearanceOff 15:52:18.030 TM.T03 01 SipTM_Terminated State change >> SipTM_Terminated->SipTM_Idle 15:52:18.031 SB.CALL 106 Clearing Called the clearResponse routine 15:52:18.032 SB.CALL 106 State change >> Clearing->CallIdlePending 15:52:18.033 SB.CCM release: 15:52:18.033 SB.CCM : Call Struct 0x2780010 : Call-ID = 106 15:52:18.034 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:18.034 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = Isdn(Group) 0/0 15:52:18.035 SB.CCM : SDP Transaction = CallID: 106 15:52:18.036 SB.CCM : SDP Offer = 0x02783010, (Carrier_IP:15780) 15:52:18.036 SB.CCM : RTP Channel = 0/1.1 15:52:18.037 SB.CCM release: Call Connection Type is RTP_TO_TDM 15:52:18.037 SB.CCM release: Releasing RTP Channel 0/1.1 15:52:18.038 RTP.CHANNEL Channel 0/1.1 released successfully. 15:52:18.038 SB.CALL 106 CallIdlePending ClearResponse sent from T03 to T01 15:52:18.039 TA.T03 01 TAClearingComplete rcvd: clear from TM 15:52:18.040 TA.T03 01 TAClearingComplete rcvd: appearance off from TM 15:52:18.040 TA.T03 01 TAClearingComplete Clear Local Variables 15:52:18.041 TA.T03 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:18.041 TM.T03 01 SipTM_Idle tachg -> TAIdle 15:52:18.042 TA.T01 clearResponse event rejected, no matching CallID106 15:52:18.043 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing RTP resource 15:52:18.044 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing 2021.02.22 15:52:18 TM.T01 01 IsdnTmStateOutboundDeliver - rcvd unexpected CallRelease 2021.02.22 15:52:18 TM.T01 01 IsdnTmStateIdling - clear trunk appearance 15:52:18.063 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:18.064 SIP.STACK MSG ACK sip:16124525510@Customer_IP SIP/2.0 15:52:18.064 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK22b3a472;rport 15:52:18.065 SIP.STACK MSG Max-Forwards: 70 15:52:18.066 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as79ff9be5 15:52:18.066 SIP.STACK MSG To: ;tag=2c51510-7f000001-13c4-521-e744ea95-521 15:52:18.067 SIP.STACK MSG Contact: 15:52:18.067 SIP.STACK MSG Call-ID: 5d39511c6dea63d06565d66f7376784e@Carrier_IP:5060 15:52:18.068 SIP.STACK MSG CSeq: 102 ACK 15:52:18.068 SIP.STACK MSG User-Agent: Prescient PBX 15:52:18.069 SIP.STACK MSG Content-Length: 0 15:52:18.069 SIP.STACK MSG 15:52:18.180 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:18.181 SIP.STACK MSG INVITE sip:16124525510@Customer_IP SIP/2.0 15:52:18.181 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK3415b359;rport 15:52:18.182 SIP.STACK MSG Max-Forwards: 70 15:52:18.182 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as36095828 15:52:18.183 SIP.STACK MSG To: 15:52:18.183 SIP.STACK MSG Contact: 15:52:18.184 SIP.STACK MSG Call-ID: 4fe380b5340726cf2b26ba0c6427eb95@Carrier_IP:5060 15:52:18.185 SIP.STACK MSG CSeq: 102 INVITE 15:52:18.185 SIP.STACK MSG User-Agent: Prescient PBX 15:52:18.186 SIP.STACK MSG Date: Mon, 22 Feb 2021 20:52:18 GMT 15:52:18.187 SIP.STACK MSG Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH 15:52:18.187 SIP.STACK MSG Supported: replaces, timer 15:52:18.188 SIP.STACK MSG P-Asserted-Identity: "WIRELESS CALLER" 15:52:18.188 SIP.STACK MSG Content-Type: application/sdp 15:52:18.189 SIP.STACK MSG Content-Length: 229 15:52:18.189 SIP.STACK MSG 15:52:18.190 SIP.STACK MSG v=0 15:52:18.190 SIP.STACK MSG o=root 1581476482 1581476482 IN IP4 Carrier_IP 15:52:18.191 SIP.STACK MSG s=Prescient PBX 15:52:18.192 SIP.STACK MSG c=IN IP4 Carrier_IP 15:52:18.192 SIP.STACK MSG t=0 0 15:52:18.193 SIP.STACK MSG m=audio 13606 RTP/AVP 0 101 15:52:18.193 SIP.STACK MSG a=rtpmap:0 PCMU/8000 15:52:18.194 SIP.STACK MSG a=rtpmap:101 telephone-event/8000 15:52:18.195 SIP.STACK MSG a=fmtp:101 0-16 15:52:18.195 SIP.STACK MSG a=ptime:20 15:52:18.196 SIP.STACK MSG a=sendrecv 15:52:18.196 SIP.STACK MSG 15:52:18.205 TM.T03 01 SipTM_Idle rcvd SIP call-leg request: INVITE 15:52:18.206 TM.T03 01 SipTM_Idle call-leg -> Offering 15:52:18.206 TM.T03 01 SipTM_Idle State change >> SipTM_Idle->SipTM_Trying 15:52:18.208 TM.T03 01 SipTM_Trying SDP offer is not loopback request 15:52:18.210 TM.T03 01 SipTM_Trying Ignoring P-Asserted-Identity header. 15:52:18.211 TM.T03 01 SipTM_Trying Processing From for Caller-ID. 15:52:18.211 TM.T03 01 SipTM_Trying Caller ID Name = "WIRELESS CALLER" 15:52:18.212 TM.T03 01 SipTM_Trying Caller ID Number = "18608109257" 15:52:18.213 TM.T03 01 SipTM_Trying info: unable to set redirect number(s) from INVITE 15:52:18.213 TM.T03 01 SipTM_Trying sent: TA->InboundCall 15:52:18.214 TM.T03 01 Looking up source address for destination Carrier_IP 15:52:18.215 TM.T03 01 call-leg (0x2c71100) -> src: Customer_IP : 5060 dst: Carrier_IP : 5060 15:52:18.219 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:18.219 SIP.STACK MSG SIP/2.0 100 Trying 15:52:18.220 SIP.STACK MSG From: "WIRELESS CALLER";tag=as36095828 15:52:18.220 SIP.STACK MSG To: 15:52:18.221 SIP.STACK MSG Call-ID: 4fe380b5340726cf2b26ba0c6427eb95@Carrier_IP:5060 15:52:18.221 SIP.STACK MSG CSeq: 102 INVITE 15:52:18.222 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK3415b359 15:52:18.223 SIP.STACK MSG Contact: 15:52:18.223 SIP.STACK MSG Supported: 100rel,replaces 15:52:18.224 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:18.224 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:18.225 SIP.STACK MSG Content-Length: 0 15:52:18.225 SIP.STACK MSG 15:52:18.226 TM.T03 01 SipTM_Trying sent: 100 Trying 15:52:18.227 TA.T03 01 TAIdle rcvd: inboundCall from TM 15:52:18.228 TA.T03 01 State change >> TAIdle->TAInboundCall (TAS_Calling) 15:52:18.229 TA.T03 01 Failed - DID translation: no match for 16124525510, using 16124525510 15:52:18.230 TA.T03 01 TAIdle sent: call to SB 15:52:18.230 TM.T03 01 SipTM_Trying tachg -> TAInboundCall 15:52:18.231 TM.T03 01 SipTM_Trying State change >> SipTM_Trying->SipTM_Pending 15:52:18.232 SB.CALL 107 Idle Called the call routine with 16124525510 15:52:18 SB.TGMgr For dialed number 16124525510, against template $, on TrunkGroup PRI-1, the score is 500 15:52:18 SB.TGMgr For dialed number 16124525510, against template 1-NXX-NXX-XXXX, on TrunkGroup AEON, the score is 2000 15:52:18.234 SB.CCM isMappable: 15:52:18.234 SB.CCM : Call Struct 0x27bec10 : Call-ID = 107 15:52:18.235 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:18.235 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = unknown 0/0 15:52:18.236 SB.CCM : SDP Transaction = CallID: 107 15:52:18.237 SB.CCM : SDP Offer = 0x0277c110, (Carrier_IP:13606) 15:52:18.237 SB.CCM isMappable: Call Connection Type is RTP_TO_TDM 15:52:18.238 SB.CCM isMappable: Reserving RTP Channel 0/1.1 15:52:18.240 SB.CCM translateOffer: offer codec list: PCMU 15:52:18.241 SB.CCM translateOffer: revised offer codec list: PCMU 15:52:18.243 SB.CCM translateOffer: codec list after answerer: PCMU 15:52:18.244 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through 15:52:18.245 SB.CCM translateOffer: success 15:52:18.246 MEDIA.MANAGER Allocating media port. 15:52:18.246 MEDIA.MANAGER getSubstitutePort: No matching callIdMap entry found for call 107 15:52:18.247 MEDIA.MANAGER Call ID map : Added new entry : call ID 107 : session root1581476482INIP4Carrier_IP : version 1581476482 : index 218 15:52:18.248 MEDIA.MANAGER New media entry : type(0), callID(107), sessionID(root1581476482INIP4Carrier_IP), original IP(Carrier_IP) ports(13606-13607), substitute IP(::) ports(10218-10219), RtpChannel(0/1.1), connection(0x2785110), sdpOverride(0), me(0x277f210). RtpChannel 0/1.1 15:52:18.249 SB.CALL 107 Idle Call sent from T03 to T01 (16124525510) 15:52:18.250 SB.CALL 107 State change >> Idle->Delivering 15:52:18.250 RTP.MANAGER Isdn(Group) 0/ - empty - RTP: Reserve resource 15:52:18.251 RTP.MANAGER Isdn(Group) 0/ - Dsp 0/1.1 - RTP: (null) 15:52:18.252 RTP.PROVIDER unknown - Dsp 0/1.1 - RTP: reserving already allocated RTP channel 15:52:18.253 TA.T03 01 TAInboundCall CallResp event accepted 15:52:18.253 TA.T03 01 State change >> TAInboundCall->TAConnectWaitIn (TAS_Calling) 15:52:18.254 TA.T01 01 State change >> TAIdle->TAOutGoing (TAS_Delivering) 15:52:18.254 TM.T01 01 tachg_Delivering 15:52:18.255 TA.T01 01 DNIS Substitution: dialed number 16124525510 -> 6124525510 15:52:18.256 TM.T01 01 IsdnTmStateIdle->IsdnTmStateOutboundDeliver 15:52:18.256 TM.T01 01 IsdnTmStateOutboundDeliver::enter() 15:52:18.257 ISDN.L2_FMT PRI 1 ============================================== 15:52:18.258 ISDN.L2_FMT PRI 1 T Sapi:00 C/R:C Tei:00 INFO Ns:0 Nr:117 P:0 15:52:18.258 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:006B 15:52:18.259 ISDN.L2_FMT PRI 1 M - 05 SETUP 15:52:18.259 ISDN.L2_FMT PRI 1 IE - 04 BEARER CAPABILITY Len=3 15:52:18.259 ISDN.L2_FMT PRI 1 80 Xfer Cap.:SPEECH 15:52:18.259 ISDN.L2_FMT PRI 1 90 Xfer Rate:64k 15:52:18.260 ISDN.L2_FMT PRI 1 A2 Layer 1:G.711 U-Law 15:52:18.260 ISDN.L2_FMT PRI 1 IE - 18 CHANNEL ID Len=3 15:52:18.261 ISDN.L2_FMT PRI 1 A1 Primary Rate 15:52:18.261 ISDN.L2_FMT PRI 1 Intfc ID:IMPLICIT 15:52:18.261 ISDN.L2_FMT PRI 1 Pref/Excl:PREFERRED 15:52:18.262 ISDN.L2_FMT PRI 1 D-Chan Indicated:NO 15:52:18.262 ISDN.L2_FMT PRI 1 Chan. Sel:FOLLOWS 15:52:18.262 ISDN.L2_FMT PRI 1 83 Numb/Map:NUMBER 15:52:18.263 ISDN.L2_FMT PRI 1 81 Channel:1 15:52:18.263 ISDN.L2_FMT PRI 1 IE - 6C CALLING PARTY # Len=13 15:52:18.263 ISDN.L2_FMT PRI 1 00 Numb. Type:UNKNOWN 15:52:18.263 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:18.264 ISDN.L2_FMT PRI 1 80 Presentation:ALLOWED 15:52:18.264 ISDN.L2_FMT PRI 1 Screening:USER PROVIDED 15:52:18.264 ISDN.L2_FMT PRI 1 Ph.# 18608109257 15:52:18.265 ISDN.L2_FMT PRI 1 IE - 70 CALLED PARTY # Len=11 15:52:18.265 ISDN.L2_FMT PRI 1 80 Numb. Type:UNKNOWN 15:52:18.265 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:18.266 ISDN.L2_FMT PRI 1 Ph.# 6124525510 15:52:18.266 SB.CALL 107 Delivering Called the deliverResponse routine from Delivering 15:52:18.267 SB.CALL 107 Delivering DeliverResponse(accept) sent from T01 to T03 15:52:18.268 TA.T03 01 TAConnectWaitIn deliverResponse event accepted 15:52:18.268 TA.T03 01 TAConnectWaitIn ERROR! deliverResponse ignored 15:52:18.350 ISDN.L2_FMT PRI 1 ============================================== 15:52:18.351 ISDN.L2_FMT PRI 1 R Sapi:00 C/R:R Tei:00 INFO Ns:117 Nr:1 P:0 15:52:18.351 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:806B 15:52:18.351 ISDN.L2_FMT PRI 1 M - 5A RELEASE_CMP 15:52:18.352 ISDN.L2_FMT PRI 1 IE - 08 CAUSE Len=2 15:52:18.352 ISDN.L2_FMT PRI 1 81 Location:LPN 15:52:18.352 ISDN.L2_FMT PRI 1 95 Cause:21 (CALL_REJECTED) 15:52:18.354 TM.T01 01 IsdnTmStateOutboundDeliver->IsdnTmStateIdling 15:52:18.355 TM.T01 01 IsdnTmStateIdling::enter() 15:52:18.355 TM.T01 01 IsdnTmStateIdling - send appearance off 15:52:18.356 TM.T01 01 IsdnTmStateIdling->IsdnTmStateIdle 15:52:18.356 TM.T01 01 IsdnAppearanceChannel::releaseChannel 15:52:18.357 TM.T01 01 IsdnTmStateIdle::enter() 15:52:18.357 TA.T01 01 TAOutGoing rcvd: clear from TM 15:52:18.358 TA.T01 01 State change >> TAOutGoing->TATrunkClearing (TAS_Clearing) 15:52:18.359 TM.T01 01 IsdnTmStateIdle::tachgClearing - send appearance off 15:52:18.359 TA.T01 01 TATrunkClearing rcvd: appearance off from TM 15:52:18.360 TA.T01 01 State change >> TATrunkClearing->TAClearingComplete (TAS_Clearing) 15:52:18.360 TA.T01 01 TATrunkClearing Processing an appearance OFF 15:52:18.361 SB.CALL 107 Delivering Called the clearCall routine 15:52:18.362 SB.CALL 107 Delivering SIP Proxy rejected call to 16124525510 for survivability - no matching Proxy user 15:52:18.362 SB.CALL 107 Delivering No available resources on call from T03 to T01 (last attempt) 15:52:18.363 SB.CALL 107 State change >> Delivering->Clearing 15:52:18.363 TA.T01 01 TAClearingComplete rcvd: appearance off from TM 15:52:18.364 TA.T01 01 TAClearingComplete Clear Local Variables 15:52:18.364 TA.T01 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:18.365 TA.T03 01 TAConnectWaitIn ClearCall event accepted 15:52:18.366 TA.T03 01 State change >> TAConnectWaitIn->TAClearingComplete (TAS_Clearing) 15:52:18.366 TM.T03 01 SipTM_Pending tachg -> TAClearingComplete 15:52:18.367 TM.T03 01 SipTM_Pending State change >> SipTM_Pending->SipTM_CallFail 15:52:18.370 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:18.370 SIP.STACK MSG SIP/2.0 403 Forbidden 15:52:18.371 SIP.STACK MSG From: "WIRELESS CALLER";tag=as36095828 15:52:18.371 SIP.STACK MSG To: ;tag=2c51718-7f000001-13c4-521-dc96f533-521 15:52:18.372 SIP.STACK MSG Call-ID: 4fe380b5340726cf2b26ba0c6427eb95@Carrier_IP:5060 15:52:18.373 SIP.STACK MSG CSeq: 102 INVITE 15:52:18.373 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK3415b359 15:52:18.374 SIP.STACK MSG Supported: 100rel,replaces 15:52:18.374 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:18.375 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:18.376 SIP.STACK MSG Content-Length: 0 15:52:18.376 SIP.STACK MSG 15:52:18.379 TM.T03 01 SipTM_CallFail call-leg -> Disconnected 15:52:18.380 TM.T03 01 SipTM_CallFail CallLegStateChanged to Disconnected - TM change to closing state. 15:52:18.380 TM.T03 01 SipTM_CallFail State change >> SipTM_CallFail->SipTM_Closing 15:52:18.381 TM.T03 01 SipTM_Closing sent: TA->Clear 15:52:18.382 TM.T03 01 SipTM_CallFail sent: 0 15:52:18.382 TM.T03 01 SipTM_Closing State change >> SipTM_Closing->SipTM_Terminated 15:52:18.383 TM.T03 01 SipTM_Terminated sent: TA->AppearanceOff 15:52:18.383 TM.T03 01 SipTM_Terminated State change >> SipTM_Terminated->SipTM_Idle 15:52:18.387 MEDIA.MANAGER Remove Call ID map entry for call 104 15:52:18.388 SB.CALL 107 Clearing Called the clearResponse routine 15:52:18.388 SB.CALL 107 State change >> Clearing->CallIdlePending 15:52:18.389 SB.CCM release: 15:52:18.389 SB.CCM : Call Struct 0x27bec10 : Call-ID = 107 15:52:18.390 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:18.391 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = Isdn(Group) 0/0 15:52:18.391 SB.CCM : SDP Transaction = CallID: 107 15:52:18.392 SB.CCM : SDP Offer = 0x0277c110, (Carrier_IP:13606) 15:52:18.392 SB.CCM : RTP Channel = 0/1.1 15:52:18.393 SB.CCM release: Call Connection Type is RTP_TO_TDM 15:52:18.393 SB.CCM release: Releasing RTP Channel 0/1.1 15:52:18.394 RTP.CHANNEL Channel 0/1.1 released successfully. 15:52:18.395 SB.CALL 107 CallIdlePending ClearResponse sent from T03 to T01 15:52:18.395 TA.T03 01 TAClearingComplete rcvd: clear from TM 15:52:18.396 TA.T03 01 TAClearingComplete rcvd: appearance off from TM 15:52:18.397 TA.T03 01 TAClearingComplete Clear Local Variables 15:52:18.397 TA.T03 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:18.398 TM.T03 01 SipTM_Idle tachg -> TAIdle 15:52:18.398 TA.T01 clearResponse event rejected, no matching CallID107 15:52:18.399 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing RTP resource 15:52:18.400 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing 2021.02.22 15:52:18 TM.T01 01 IsdnTmStateOutboundDeliver - rcvd unexpected CallRelease 2021.02.22 15:52:18 TM.T01 01 IsdnTmStateIdling - clear trunk appearance 15:52:18.416 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:18.417 SIP.STACK MSG ACK sip:16124525510@Customer_IP SIP/2.0 15:52:18.418 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK3415b359;rport 15:52:18.418 SIP.STACK MSG Max-Forwards: 70 15:52:18.419 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as36095828 15:52:18.419 SIP.STACK MSG To: ;tag=2c51718-7f000001-13c4-521-dc96f533-521 15:52:18.420 SIP.STACK MSG Contact: 15:52:18.420 SIP.STACK MSG Call-ID: 4fe380b5340726cf2b26ba0c6427eb95@Carrier_IP:5060 15:52:18.421 SIP.STACK MSG CSeq: 102 ACK 15:52:18.422 SIP.STACK MSG User-Agent: Prescient PBX 15:52:18.422 SIP.STACK MSG Content-Length: 0 15:52:18.423 SIP.STACK MSG 2021.02.22 15:52:19 SMDR 106 02/22/2021 15:52:17 0.0 0 E 00/00 WIRELESS CALLER 18608109257 00/00 T01 16124525510 0 N 15:52:19.394 MEDIA.MANAGER Remove Call ID map entry for call 105 2021.02.22 15:52:19 SMDR 107 02/22/2021 15:52:18 0.0 0 E 00/00 WIRELESS CALLER 18608109257 00/00 T01 16124525510 0 N 15:52:19.646 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:19.647 SIP.STACK MSG INVITE sip:16124525510@Customer_IP SIP/2.0 15:52:19.648 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK0be53d4d;rport 15:52:19.648 SIP.STACK MSG Max-Forwards: 70 15:52:19.649 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as0a56a51e 15:52:19.649 SIP.STACK MSG To: 15:52:19.650 SIP.STACK MSG Contact: 15:52:19.651 SIP.STACK MSG Call-ID: 31fac03f7a22fb063fd3d9d7317cc3cd@Carrier_IP:5060 15:52:19.651 SIP.STACK MSG CSeq: 102 INVITE 15:52:19.652 SIP.STACK MSG User-Agent: Prescient PBX 15:52:19.652 SIP.STACK MSG Date: Mon, 22 Feb 2021 20:52:19 GMT 15:52:19.653 SIP.STACK MSG Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH 15:52:19.654 SIP.STACK MSG Supported: replaces, timer 15:52:19.654 SIP.STACK MSG P-Asserted-Identity: "WIRELESS CALLER" 15:52:19.655 SIP.STACK MSG Content-Type: application/sdp 15:52:19.655 SIP.STACK MSG Content-Length: 227 15:52:19.656 SIP.STACK MSG 15:52:19.657 SIP.STACK MSG v=0 15:52:19.657 SIP.STACK MSG o=root 928745020 928745020 IN IP4 Carrier_IP 15:52:19.658 SIP.STACK MSG s=Prescient PBX 15:52:19.658 SIP.STACK MSG c=IN IP4 Carrier_IP 15:52:19.659 SIP.STACK MSG t=0 0 15:52:19.659 SIP.STACK MSG m=audio 10280 RTP/AVP 0 101 15:52:19.660 SIP.STACK MSG a=rtpmap:0 PCMU/8000 15:52:19.660 SIP.STACK MSG a=rtpmap:101 telephone-event/8000 15:52:19.661 SIP.STACK MSG a=fmtp:101 0-16 15:52:19.662 SIP.STACK MSG a=ptime:20 15:52:19.662 SIP.STACK MSG a=sendrecv 15:52:19.663 SIP.STACK MSG 15:52:19.672 TM.T03 01 SipTM_Idle rcvd SIP call-leg request: INVITE 15:52:19.673 TM.T03 01 SipTM_Idle call-leg -> Offering 15:52:19.673 TM.T03 01 SipTM_Idle State change >> SipTM_Idle->SipTM_Trying 15:52:19.675 TM.T03 01 SipTM_Trying SDP offer is not loopback request 15:52:19.677 TM.T03 01 SipTM_Trying Ignoring P-Asserted-Identity header. 15:52:19.678 TM.T03 01 SipTM_Trying Processing From for Caller-ID. 15:52:19.679 TM.T03 01 SipTM_Trying Caller ID Name = "WIRELESS CALLER" 15:52:19.679 TM.T03 01 SipTM_Trying Caller ID Number = "18608109257" 15:52:19.680 TM.T03 01 SipTM_Trying info: unable to set redirect number(s) from INVITE 15:52:19.681 TM.T03 01 SipTM_Trying sent: TA->InboundCall 15:52:19.681 TM.T03 01 Looking up source address for destination Carrier_IP 15:52:19.682 TM.T03 01 call-leg (0x2c71330) -> src: Customer_IP : 5060 dst: Carrier_IP : 5060 15:52:19.685 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:19.686 SIP.STACK MSG SIP/2.0 100 Trying 15:52:19.686 SIP.STACK MSG From: "WIRELESS CALLER";tag=as0a56a51e 15:52:19.687 SIP.STACK MSG To: 15:52:19.687 SIP.STACK MSG Call-ID: 31fac03f7a22fb063fd3d9d7317cc3cd@Carrier_IP:5060 15:52:19.688 SIP.STACK MSG CSeq: 102 INVITE 15:52:19.688 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK0be53d4d 15:52:19.689 SIP.STACK MSG Contact: 15:52:19.690 SIP.STACK MSG Supported: 100rel,replaces 15:52:19.690 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:19.691 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:19.692 SIP.STACK MSG Content-Length: 0 15:52:19.692 SIP.STACK MSG 15:52:19.693 TM.T03 01 SipTM_Trying sent: 100 Trying 15:52:19.694 TA.T03 01 TAIdle rcvd: inboundCall from TM 15:52:19.695 TA.T03 01 State change >> TAIdle->TAInboundCall (TAS_Calling) 15:52:19.695 TA.T03 01 Failed - DID translation: no match for 16124525510, using 16124525510 15:52:19.696 TA.T03 01 TAIdle sent: call to SB 15:52:19.697 TM.T03 01 SipTM_Trying tachg -> TAInboundCall 15:52:19.697 TM.T03 01 SipTM_Trying State change >> SipTM_Trying->SipTM_Pending 15:52:19.698 SB.CALL 108 Idle Called the call routine with 16124525510 15:52:19 SB.TGMgr For dialed number 16124525510, against template $, on TrunkGroup PRI-1, the score is 500 15:52:19 SB.TGMgr For dialed number 16124525510, against template 1-NXX-NXX-XXXX, on TrunkGroup AEON, the score is 2000 15:52:19.700 SB.CCM isMappable: 15:52:19.701 SB.CCM : Call Struct 0x2780010 : Call-ID = 108 15:52:19.701 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:19.702 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = unknown 0/0 15:52:19.702 SB.CCM : SDP Transaction = CallID: 108 15:52:19.703 SB.CCM : SDP Offer = 0x027c3b10, (Carrier_IP:10280) 15:52:19.704 SB.CCM isMappable: Call Connection Type is RTP_TO_TDM 15:52:19.705 SB.CCM isMappable: Reserving RTP Channel 0/1.1 15:52:19.707 SB.CCM translateOffer: offer codec list: PCMU 15:52:19.708 SB.CCM translateOffer: revised offer codec list: PCMU 15:52:19.709 SB.CCM translateOffer: codec list after answerer: PCMU 15:52:19.711 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through 15:52:19.712 SB.CCM translateOffer: success 15:52:19.713 MEDIA.MANAGER Allocating media port. 15:52:19.713 MEDIA.MANAGER getSubstitutePort: No matching callIdMap entry found for call 108 15:52:19.714 MEDIA.MANAGER Call ID map : Added new entry : call ID 108 : session root928745020INIP4Carrier_IP : version 928745020 : index 220 15:52:19.715 MEDIA.MANAGER New media entry : type(0), callID(108), sessionID(root928745020INIP4Carrier_IP), original IP(Carrier_IP) ports(10280-10281), substitute IP(::) ports(10220-10221), RtpChannel(0/1.1), connection(0x277f310), sdpOverride(0), me(0x277c110). RtpChannel 0/1.1 15:52:19.716 SB.CALL 108 Idle Call sent from T03 to T01 (16124525510) 15:52:19.716 SB.CALL 108 State change >> Idle->Delivering 15:52:19.717 RTP.MANAGER Isdn(Group) 0/ - empty - RTP: Reserve resource 15:52:19.718 RTP.MANAGER Isdn(Group) 0/ - Dsp 0/1.1 - RTP: (null) 15:52:19.718 RTP.PROVIDER unknown - Dsp 0/1.1 - RTP: reserving already allocated RTP channel 15:52:19.719 TA.T03 01 TAInboundCall CallResp event accepted 15:52:19.719 TA.T03 01 State change >> TAInboundCall->TAConnectWaitIn (TAS_Calling) 15:52:19.720 TA.T01 01 State change >> TAIdle->TAOutGoing (TAS_Delivering) 15:52:19.721 TM.T01 01 tachg_Delivering 15:52:19.722 TA.T01 01 DNIS Substitution: dialed number 16124525510 -> 6124525510 15:52:19.722 TM.T01 01 IsdnTmStateIdle->IsdnTmStateOutboundDeliver 15:52:19.723 TM.T01 01 IsdnTmStateOutboundDeliver::enter() 15:52:19.724 ISDN.L2_FMT PRI 1 ============================================== 15:52:19.725 ISDN.L2_FMT PRI 1 T Sapi:00 C/R:C Tei:00 INFO Ns:1 Nr:118 P:0 15:52:19.725 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:006C 15:52:19.725 ISDN.L2_FMT PRI 1 M - 05 SETUP 15:52:19.725 ISDN.L2_FMT PRI 1 IE - 04 BEARER CAPABILITY Len=3 15:52:19.726 ISDN.L2_FMT PRI 1 80 Xfer Cap.:SPEECH 15:52:19.726 ISDN.L2_FMT PRI 1 90 Xfer Rate:64k 15:52:19.726 ISDN.L2_FMT PRI 1 A2 Layer 1:G.711 U-Law 15:52:19.727 ISDN.L2_FMT PRI 1 IE - 18 CHANNEL ID Len=3 15:52:19.727 ISDN.L2_FMT PRI 1 A1 Primary Rate 15:52:19.727 ISDN.L2_FMT PRI 1 Intfc ID:IMPLICIT 15:52:19.728 ISDN.L2_FMT PRI 1 Pref/Excl:PREFERRED 15:52:19.728 ISDN.L2_FMT PRI 1 D-Chan Indicated:NO 15:52:19.728 ISDN.L2_FMT PRI 1 Chan. Sel:FOLLOWS 15:52:19.729 ISDN.L2_FMT PRI 1 83 Numb/Map:NUMBER 15:52:19.729 ISDN.L2_FMT PRI 1 81 Channel:1 15:52:19.729 ISDN.L2_FMT PRI 1 IE - 6C CALLING PARTY # Len=13 15:52:19.729 ISDN.L2_FMT PRI 1 00 Numb. Type:UNKNOWN 15:52:19.730 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:19.730 ISDN.L2_FMT PRI 1 80 Presentation:ALLOWED 15:52:19.730 ISDN.L2_FMT PRI 1 Screening:USER PROVIDED 15:52:19.731 ISDN.L2_FMT PRI 1 Ph.# 18608109257 15:52:19.731 ISDN.L2_FMT PRI 1 IE - 70 CALLED PARTY # Len=11 15:52:19.731 ISDN.L2_FMT PRI 1 80 Numb. Type:UNKNOWN 15:52:19.732 ISDN.L2_FMT PRI 1 Numb. Plan:UNKNOWN 15:52:19.732 ISDN.L2_FMT PRI 1 Ph.# 6124525510 15:52:19.733 SB.CALL 108 Delivering Called the deliverResponse routine from Delivering 15:52:19.733 SB.CALL 108 Delivering DeliverResponse(accept) sent from T01 to T03 15:52:19.734 TA.T03 01 TAConnectWaitIn deliverResponse event accepted 15:52:19.735 TA.T03 01 TAConnectWaitIn ERROR! deliverResponse ignored 15:52:19.817 ISDN.L2_FMT PRI 1 ============================================== 15:52:19.817 ISDN.L2_FMT PRI 1 R Sapi:00 C/R:R Tei:00 INFO Ns:118 Nr:2 P:0 15:52:19.817 ISDN.L2_FMT PRI 1 Prot:08 CRL:2 CRV:806C 15:52:19.818 ISDN.L2_FMT PRI 1 M - 5A RELEASE_CMP 15:52:19.818 ISDN.L2_FMT PRI 1 IE - 08 CAUSE Len=2 15:52:19.818 ISDN.L2_FMT PRI 1 81 Location:LPN 15:52:19.819 ISDN.L2_FMT PRI 1 95 Cause:21 (CALL_REJECTED) 15:52:19.820 TM.T01 01 IsdnTmStateOutboundDeliver->IsdnTmStateIdling 15:52:19.821 TM.T01 01 IsdnTmStateIdling::enter() 15:52:19.822 TM.T01 01 IsdnTmStateIdling - send appearance off 15:52:19.822 TM.T01 01 IsdnTmStateIdling->IsdnTmStateIdle 15:52:19.823 TM.T01 01 IsdnAppearanceChannel::releaseChannel 15:52:19.823 TM.T01 01 IsdnTmStateIdle::enter() 15:52:19.824 TA.T01 01 TAOutGoing rcvd: clear from TM 15:52:19.825 TA.T01 01 State change >> TAOutGoing->TATrunkClearing (TAS_Clearing) 15:52:19.825 TM.T01 01 IsdnTmStateIdle::tachgClearing - send appearance off 15:52:19.826 TA.T01 01 TATrunkClearing rcvd: appearance off from TM 15:52:19.826 TA.T01 01 State change >> TATrunkClearing->TAClearingComplete (TAS_Clearing) 15:52:19.827 TA.T01 01 TATrunkClearing Processing an appearance OFF 15:52:19.827 SB.CALL 108 Delivering Called the clearCall routine 15:52:19.828 SB.CALL 108 Delivering SIP Proxy rejected call to 16124525510 for survivability - no matching Proxy user 15:52:19.829 SB.CALL 108 Delivering No available resources on call from T03 to T01 (last attempt) 15:52:19.829 SB.CALL 108 State change >> Delivering->Clearing 15:52:19.830 TA.T01 01 TAClearingComplete rcvd: appearance off from TM 15:52:19.830 TA.T01 01 TAClearingComplete Clear Local Variables 15:52:19.831 TA.T01 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:19.832 TA.T03 01 TAConnectWaitIn ClearCall event accepted 15:52:19.832 TA.T03 01 State change >> TAConnectWaitIn->TAClearingComplete (TAS_Clearing) 15:52:19.833 TM.T03 01 SipTM_Pending tachg -> TAClearingComplete 15:52:19.834 TM.T03 01 SipTM_Pending State change >> SipTM_Pending->SipTM_CallFail 15:52:19.836 SIP.STACK MSG Tx: UDP src=Customer_IP:5060 dst=Carrier_IP:5060 15:52:19.837 SIP.STACK MSG SIP/2.0 403 Forbidden 15:52:19.837 SIP.STACK MSG From: "WIRELESS CALLER";tag=as0a56a51e 15:52:19.838 SIP.STACK MSG To: ;tag=2c51920-7f000001-13c4-523-fe477df1-523 15:52:19.838 SIP.STACK MSG Call-ID: 31fac03f7a22fb063fd3d9d7317cc3cd@Carrier_IP:5060 15:52:19.839 SIP.STACK MSG CSeq: 102 INVITE 15:52:19.840 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;rport=5060;branch=z9hG4bK0be53d4d 15:52:19.840 SIP.STACK MSG Supported: 100rel,replaces 15:52:19.841 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER 15:52:19.842 SIP.STACK MSG User-Agent: ADTRAN_Total_Access_904_2nd_Gen/R11.4.3.E 15:52:19.842 SIP.STACK MSG Content-Length: 0 15:52:19.843 SIP.STACK MSG 15:52:19.846 TM.T03 01 SipTM_CallFail call-leg -> Disconnected 15:52:19.846 TM.T03 01 SipTM_CallFail CallLegStateChanged to Disconnected - TM change to closing state. 15:52:19.847 TM.T03 01 SipTM_CallFail State change >> SipTM_CallFail->SipTM_Closing 15:52:19.847 TM.T03 01 SipTM_Closing sent: TA->Clear 15:52:19.848 TM.T03 01 SipTM_CallFail sent: 0 15:52:19.848 TM.T03 01 SipTM_Closing State change >> SipTM_Closing->SipTM_Terminated 15:52:19.849 TM.T03 01 SipTM_Terminated sent: TA->AppearanceOff 15:52:19.849 TM.T03 01 SipTM_Terminated State change >> SipTM_Terminated->SipTM_Idle 15:52:19.851 SB.CALL 108 Clearing Called the clearResponse routine 15:52:19.851 SB.CALL 108 State change >> Clearing->CallIdlePending 15:52:19.852 SB.CCM release: 15:52:19.853 SB.CCM : Call Struct 0x2780010 : Call-ID = 108 15:52:19.853 SB.CCM : Org Acct = T03 Dst Acct = T01 15:52:19.854 SB.CCM : Org Port ID = SipTrunk 0/0.42 Dst Port ID = Isdn(Group) 0/0 15:52:19.854 SB.CCM : SDP Transaction = CallID: 108 15:52:19.855 SB.CCM : SDP Offer = 0x027c3b10, (Carrier_IP:10280) 15:52:19.856 SB.CCM : RTP Channel = 0/1.1 15:52:19.856 SB.CCM release: Call Connection Type is RTP_TO_TDM 15:52:19.857 SB.CCM release: Releasing RTP Channel 0/1.1 15:52:19.857 RTP.CHANNEL Channel 0/1.1 released successfully. 15:52:19.858 SB.CALL 108 CallIdlePending ClearResponse sent from T03 to T01 15:52:19.859 TA.T03 01 TAClearingComplete rcvd: clear from TM 15:52:19.859 TA.T03 01 TAClearingComplete rcvd: appearance off from TM 15:52:19.860 TA.T03 01 TAClearingComplete Clear Local Variables 15:52:19.860 TA.T03 01 State change >> TAClearingComplete->TAIdle (TAS_Idle) 15:52:19.861 TM.T03 01 SipTM_Idle tachg -> TAIdle 15:52:19.861 TA.T01 clearResponse event rejected, no matching CallID108 15:52:19.862 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing RTP resource 15:52:19.863 RTP.CHANNEL unknown - Dsp 0/1.1 - RTP: releasing 2021.02.22 15:52:19 TM.T01 01 IsdnTmStateOutboundDeliver - rcvd unexpected CallRelease 2021.02.22 15:52:19 TM.T01 01 IsdnTmStateIdling - clear trunk appearance 15:52:19.882 SIP.STACK MSG Rx: UDP src=Carrier_IP:5060 dst=Customer_IP:5060 15:52:19.883 SIP.STACK MSG ACK sip:16124525510@Customer_IP SIP/2.0 15:52:19.884 SIP.STACK MSG Via: SIP/2.0/UDP Carrier_IP:5060;branch=z9hG4bK0be53d4d;rport 15:52:19.885 SIP.STACK MSG Max-Forwards: 70 15:52:19.885 SIP.STACK MSG From: "WIRELESS CALLER" ;tag=as0a56a51e 15:52:19.886 SIP.STACK MSG To: ;tag=2c51920-7f000001-13c4-523-fe477df1-523 15:52:19.886 SIP.STACK MSG Contact: 15:52:19.887 SIP.STACK MSG Call-ID: 31fac03f7a22fb063fd3d9d7317cc3cd@Carrier_IP:5060 15:52:19.887 SIP.STACK MSG CSeq: 102 ACK 15:52:19.888 SIP.STACK MSG User-Agent: Prescient PBX 15:52:19.888 SIP.STACK MSG Content-Length: 0 15:52:19.889 SIP.STACK MSG 15:52:20.398 MEDIA.MANAGER Remove Call ID map entry for call 106 2021.02.22 15:52:20 SMDR 108 02/22/2021 15:52:19 0.0 0 E 00/00 WIRELESS CALLER 18608109257 00/00 T01 16124525510 0 N 15:52:21.404 MEDIA.MANAGER Remove Call ID map entry for call 107 15:52:22.408 MEDIA.MANAGER Remove Call ID map entry for call 108undebug all