4 Replies Latest reply on May 31, 2017 2:08 PM by triassicsoul1

    Cannot transfer call to external number

    triassicsoul1 New Member

      We use TA900 series on our own private IP network (no NAT and no outside IP access to management).  The problem is we can't transfer an active call to an external number.  Regardless whether the customer has a PBX or analog phones only, when attempting a hookflash to transfer an active call, both parties of the active call hear a click, but both parties remain connected.  The IAD customer attempting the hookflash does not get dial tone in order to dial digits to transfer the call.  The non-IAD caller is not put on hold.

       

      Architecture is SIP trunk to the IAD, analog to the phone. The TA908 Gen2 is on FW R12.3.1

      1111111111 = Calling Party

      2222222222 = Called Party (who is trying to transfer the call)

       

      The hookflash originates on the TA908.  The switch "sees" the event and responds back to the TA908 with an accept.

      Here is the debug output.  Would someone kindly help me figure out what is happening?  MUCH THANKS!!!

       

       

      test#debug voice switchboard

      test#debug voice summary

      test#debug sip stack messages

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      07:07:02.681 SIP.STACK MSG     Rx: UDP src=192.168.61.19:5060 dst=192.168.61.200:5060

      07:07:02.682 SIP.STACK MSG         INVITE sip:2222222222@192.168.61.200:5060;user=phone SIP/2.0

      07:07:02.682 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.19:5060;branch=z9hG4bK-00102-koh450dx2egzB94-0

      07:07:02.683 SIP.STACK MSG         Max-Forwards: 6

      07:07:02.684 SIP.STACK MSG         Record-Route: <sip:1293172737@192.168.61.19:5060;lr>

      07:07:02.684 SIP.STACK MSG         From: "City & State" <sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:07:02.685 SIP.STACK MSG         To: sip:2222222222@192.168.61.200:5060

      07:07:02.685 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:07:02.686 SIP.STACK MSG         CSeq: 102 INVITE

      07:07:02.687 SIP.STACK MSG         Expires: 180

      07:07:02.687 SIP.STACK MSG         Allow: UPDATE,INVITE,CANCEL,BYE,ACK

      07:07:02.688 SIP.STACK MSG         Supported: 100rel

      07:07:02.688 SIP.STACK MSG         Contact: sip:192.168.61.19:5060

      07:07:02.689 SIP.STACK MSG         User-Agent: Taqua-T7000-R6.4.0

      07:07:02.690 SIP.STACK MSG         Content-Type: application/sdp

      07:07:02.690 SIP.STACK MSG         Content-Length: 218

      07:07:02.691 SIP.STACK MSG    

      07:07:02.691 SIP.STACK MSG         v=0

      07:07:02.692 SIP.STACK MSG         o=- 3044814 3044814 IN IP4 192.168.61.19

      07:07:02.693 SIP.STACK MSG         s=SIP Call

      07:07:02.693 SIP.STACK MSG         c=IN IP4 192.168.61.119

      07:07:02.694 SIP.STACK MSG         t=0 0

      07:07:02.694 SIP.STACK MSG         m=audio 56466 RTP/AVP 0 101

      07:07:02.695 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

      07:07:02.695 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

      07:07:02.696 SIP.STACK MSG         a=fmtp:101 0-15

      07:07:02.697 SIP.STACK MSG         a=ptime:20

      07:07:02.697 SIP.STACK MSG         a=sendrecv

      07:07:02.698 SIP.STACK MSG    

      07:07:02.704 TM.T01 01 SipTM_Idle           rcvd SIP call-leg request: INVITE

      07:07:02.706 TM.T01 01 SipTM_Idle           call-leg -> Offering

      07:07:02.706 TM.T01 01 SipTM_Idle           State change      >> SipTM_Idle->SipTM_Trying

      07:07:02.708 TM.T01 01 SipTM_Trying         SDP offer is not loopback request

      07:07:02.709 TM.T01 01 SipTM_Trying         Processing From for Caller-ID.

      07:07:02.709 TM.T01 01 SipTM_Trying         Caller ID Name   = "City & State"

      07:07:02.710 TM.T01 01 SipTM_Trying         Caller ID Number = "1111111111"

      07:07:02.711 TM.T01 01 SipTM_Trying         info: unable to set redirect number(s) from INVITE

      07:07:02.712 TM.T01 01 SipTM_Trying         sent: TA->InboundCall

      07:07:02.712 TM.T01 01 Looking up source address for destination 192.168.61.19

      07:07:02.713 TM.T01 01 call-leg (0x31c30c0) -> src: 192.168.61.200 : 5060  dst: 192.168.61.19 : 5060

      07:07:02.717 SIP.STACK MSG     Tx: UDP src=192.168.61.200:5060 dst=192.168.61.19:5060

      07:07:02.717 SIP.STACK MSG         SIP/2.0 100 Trying

      07:07:02.718 SIP.STACK MSG         From: "City & State"<sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:07:02.718 SIP.STACK MSG         To: <sip:2222222222@192.168.61.200:5060>

      07:07:02.719 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:07:02.720 SIP.STACK MSG         CSeq: 102 INVITE

      07:07:02.720 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.19:5060;branch=z9hG4bK-00102-koh450dx2egzB94-0

      07:07:02.721 SIP.STACK MSG         Contact: <sip:2222222222@192.168.61.200:5060;transport=UDP>

      07:07:02.721 SIP.STACK MSG         Supported: 100rel,replaces

      07:07:02.722 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

      07:07:02.723 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908_2nd_Gen/R12.3.1.E

      07:07:02.723 SIP.STACK MSG         Content-Length: 0

      07:07:02.724 SIP.STACK MSG    

      07:07:02.725 TM.T01 01 SipTM_Trying         sent: 100 Trying

      07:07:02.726 TA.T01 01 TAIdle               rcvd: inboundCall from TM

      07:07:02.726 TA.T01 01 State change      >> TAIdle->TAInboundCall (TAS_Calling)

      07:07:02.727 TA.T01 01 Success - DID resolved 2222222222 to 8001

      07:07:02.728 TA.T01 01 TAIdle               sent: call to SB

      07:07:02.729 TM.T01 01 SipTM_Trying         tachg -> TAInboundCall

      07:07:02.730 TM.T01 01 SipTM_Trying         State change      >> SipTM_Trying->SipTM_Pending

      07:07:02.731 SB.CALL 1 Idle                 Called the call routine with 8001

      07:07:02.731 SB.CCM isMappable:

      07:07:02.732 SB.CCM  :  Call Struct 0x31f1810 :   Call-ID = 1

      07:07:02.733 SB.CCM  :  Org Acct = T01    Dst Acct = 8001

      07:07:02.733 SB.CCM  : -1292-19-17at192.168.61.19

      07:07:02.793 SIP.STACK MSG         To: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:07:02.794 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:07:02.794 SIP.STACK MSG         CSeq: 102 INVITE

      07:07:02.795 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.19:5060;branch=z9hG4bK-00102-koh450dx2egzB94-0

      07:07:02.795 SIP.STACK MSG         Contact: <sip:2222222222@192.168.61.200:5060;transport=UDP>

      07:07:02.796 SIP.STACK MSG         Record-Route: <sip:1293172737@192.168.61.19:5060;lr>

      07:07:02.797 SIP.STACK MSG         Supported: 100rel,replaces

      07:07:02.797 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

      07:07:02.798 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908_2nd_Gen/R12.3.1.E

      07:07:02.798 SIP.STACK MSG         Content-Length: 0

      07:07:02.799 SIP.STACK MSG    

      07:07:02.800 TM.T01 01 SipTM_Alerting       Sent 180 Ringing

      07:07:02 SB.CallStructObserver 1 Created

      07:07:02 SB.CallStructObserver 1 <-> koh450dx2egzB94@192.168.61.19

      07:07:02 SB.CallStructObserver 2 Created

      07:07:05.803 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation: starting Caller-ID alert and sending Caller-ID information:

      07:07:05.804 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation:   chars = ".'..01010707..1111111111..City & State."

      07:07:05.804 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation:   bytes = "80 27 01 08 30 31 30 31 30 37 30 37 02 0A 32 36 30 38 34 36 30 36 39 39 07 0F 42 6C 75 66 66 74 6F 6E 20 20 20 20 20 49 4E 15"

      07:07:05.805 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation: TDM map

      07:07:06.621 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation: received Caller-ID Done event

      07:07:06.622 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation: stopping

      07:07:06.623 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation: TDM unmap

      07:07:06.624 RTP.CHANNEL fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation: releasing RTP resource

      07:07:06.625 TONESERVICES.EVENTS fxs 0/1 - Dsp 0/1.2 - Caller-ID Generation: release

      07:07:14.483 PM.0:1 Ringing              Processed OFFHOOK

      07:07:14.484 PM.0:1 State change      >> Ringing->Connected

      07:07:14.485 SA.2222222222 Ca:0 Ringing              rcvd: AcctPhoneMgr_connect from PM

      07:07:14.486 SA.2222222222 Ca:0 Ringing              sent: connect to SB

      07:07:14.486 SA.2222222222 Ca:0 Ringing              State change      >> Ringing->Connecting (CAS_Active)

      07:07:14.487 SB.CALL 2 Alerting             Called the connect routine

      07:07:14.487 SB.CCM isResponseMappable:

      07:07:14.488 SB.CCM  :  Call Struct 0x31f1c10 :   Call-ID = 2

      07:07:14.488 SB.CCM  :  Org Acct = 8001    Dst Acct = 2222222222

      07:07:14.489 SB.CCM  :  Org Port ID = RingGroup 0/0   Dst Port ID = FxsPhone 0/1

      07:07:14.490 SB.CCM  :  SDP Transaction = CallID: 2

      07:07:14.491 SB.CCM  :  SDP Offer = 0x02cf0d10, ([::1]:60000)

      07:07:14.491 SB.CCM  :  RTP Channel = 0/1.1

      07:07:14.492 SB.CCM isResponseMappable: reversing call connection type to compensate for event originator direction

      07:07:14.492 SB.CCM isResponseMappable: Call Connection Type is TDM_TO_RG

      07:07:14.493 SB.CCM isResponseMappable: Creating SDP Answer based on SDP Offer

      07:07:14.493 SB.CCM createAnswer: creating SDP answer using RTP channel 0/1.1

      07:07:14.495 SB.CCM createAnswer : offer  codec list: PCMU

      07:07:14.496 SB.CCM              : answer codec list: PCMU

      07:07:14.496 SB.CCM updateAnswerWithEndpointConfig: no endpoint configuration to update with

      07:07:14.500 SB.CCM createAnswer : result codec list: PCMU

      07:07:14.501 SB.CCM createAnswer : final DTMF signaling(NTE 101)

      07:07:14.502 MEDIA.MANAGER getSubstitutePort: No matching callIdMap entry found for call 2

      07:07:14.502 SB.CCM updateMediaEntryForReinviteWithSameSdp : no substitute port found for offer SDP callId (2) sessionId (-43622INIP6::1) remote port (60000)

      07:07:14.504 SB.CCM translateAnswer: offer  codec list: PCMU

      07:07:14.504 SB.CCM                : answer codec list: PCMU

      07:07:14.506 SB.CCM translateAnswer: CODEC transcoding is not required

      07:07:14.507 SB.CCM translateAnswer: offer / answer DTMF signaling identical: DTMF transcoding not required

      07:07:14.508 SB.CCM translateAnswer: success

      07:07:14.509 MEDIA.MANAGER Allocating media port.

      07:07:14.510 MEDIA.MANAGER getSubstitutePort: No matching callIdMap entry found for call 2

      07:07:14.511 MEDIA.MANAGER Call ID map : Added new entry : call ID 2 : session -43634INIP4127.0.0.3 : version 2 : index 2

      07:07:14.512 MEDIA.MANAGER New media entry : type(0), callID(2), sessionID(-43634INIP4127.0.0.3), original IP(127.0.0.3) ports(10002-10003), substitute IP(::) ports(10002-10003), RtpChannel(0/1.1), connection(0x2cf0f10), sdpOverride(0), me(0x2cf0e10). RtpChannel 0/1.1

      07:07:14.513 SB.CALL 2 Alerting             Connect sent from 2222222222 to 8001

      07:07:14.514 SB.CALL 2 State change      >> Alerting->Connecting

      07:07:14.518 RG.8001 app. 1 in from 1111111111 State change      >> Ringing->Transfer Pending

      07:07:14.518 RG.8001 app. 10000 out to 2222222222 State change      >> Calling->Transfering

      07:07:14.519 SB.CALL 2 Connecting           Called the connectResponse routine

      07:07:14.520 VOICE.SUMMARY 8001 is connected to 2222222222 (2222222222)

      07:07:14.521 SB.CALL 2 Connecting           ConnectResponse sent from 8001 to 2222222222

      07:07:14.521 SB.CALL 1 Alerting             Called the connect routine

      07:07:14.522 SB.CCM isResponseMappable:

      07:07:14.522 SB.CCM  :  Call Struct 0x31f1810 :   Call-ID = 1

      07:07:14.523 SB.CCM  :  Org Acct = T01    Dst Acct = 8001

      07:07:14.524 SB.CCM  :  Org Port ID = SipTrunk 0/0   Dst Port ID = RingGroup 0/0

      07:07:14.524 SB.CCM  :  SDP Transaction = CallID: 1

      07:07:14.525 SB.CCM  :  SDP Offer = 0x02cef510, (192.168.61.119:56466)

      07:07:14.526 SB.CCM  :  RTP Channel = 0/1.1

      07:07:14.526 SB.CCM isResponseMappable: reversing call connection type to compensate for event originator direction

      07:07:14.527 SB.CCM isResponseMappable: Call Connection Type is RG_TO_RTP

      07:07:14.527 SB.CALL 1 Alerting             Connect sent from 8001 to T01

      07:07:14.528 SB.CALL 1 State change      >> Alerting->Connecting

      07:07:14.529 SA.2222222222 Ca:0 Connecting           rcvd: connectResponse from SB

      07:07:14.529 SA.2222222222 Ca:0 Connecting           State change      >> Connecting->Connected (CAS_Connected)

      07:07:14.530 SA.2222222222 Ca:0 Connected            sent: AcctPhoneMgr_cachg(CAS_Connected) to PM

      07:07:14.530 PM.0:1 Connected            Processed CACHG:Connected

      07:07:14.531 PM.0:1 State change      >> Connected->Connected

      07:07:14.531 PM.0:1 Connected            sent: finalizeConnect to SA

      07:07:14.532 SA.2222222222 Ca:0 Connected            sent: AcctPhoneMgr_info to PM

      07:07:14.533 PM.0:1 ERROR! APM_Info ignored

      07:07:14.533 TA.T01 01 TAConnectWaitIn      connect event accepted

      07:07:14.534 TA.T01 01 State change      >> TAConnectWaitIn->TAConnectPending (TAS_Connected)

      07:07:14.535 TM.T01 01 SipTM_Alerting       tachg -> TAConnectPending

      07:07:14.535 TM.T01 01 SipTM_Alerting       State change      >> SipTM_Alerting->SipTM_Accept

      07:07:14.536 TM.T01 01 SDP DPI call ID 1 : No media bin.

      07:07:14.537 TM.T01 01 Processing new SDP entries.

      07:07:14.538 TM.T01 01 Checking for internal Media Gateway IP Address

      07:07:14.539 TM.T01 01 Using RTP Channel 0/1.1

      07:07:14.539 TM.T01 01 Inserting 192.168.61.200 into SDP for Media Gateway

      07:07:14.540 MEDIA.MANAGER getSubstitutePort: Matching callIdMap entry found for call 1 sessionId -43635INIP6::1 remote port 60000

      07:07:14.541 MEDIA.MANAGER Call ID map : Added new session ID : call ID 1 : session -43635INIP6::1 : version 1 : index 4

      07:07:14.542 MEDIA.MANAGER New media entry : type(0), callID(1), sessionID(-43635INIP6::1), original IP(::1) ports(60000-60001), substitute IP(192.168.61.200) ports(10004-10005), RtpChannel(0/1.1), connection(0x2cf1510), sdpOverride(0), me(0x2cf0d10). RtpChannel 0/1.1

      07:07:14.543 TM.T01 01 Adding RTP Media Gateway Entry: [::1]:60000 -> 192.168.61.200:60000

      07:07:14.543 TM.T01 01 Allocating anchor ports 10004 and 10005 for interface 192.168.61.200

      07:07:14.548 SIP.STACK MSG     Tx: UDP src=192.168.61.200:5060 dst=192.168.61.19:5060

      07:07:14.548 SIP.STACK MSG         SIP/2.0 200 OK

      07:07:14.549 SIP.STACK MSG         From: "City & State"<sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:07:14.550 SIP.STACK MSG         To: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:07:14.550 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:07:14.551 SIP.STACK MSG         CSeq: 102 INVITE

      07:07:14.552 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.19:5060;branch=z9hG4bK-00102-koh450dx2egzB94-0

      07:07:14.552 SIP.STACK MSG         Contact: <sip:2222222222@192.168.61.200:5060;transport=UDP>

      07:07:14.553 SIP.STACK MSG         Record-Route: <sip:1293172737@192.168.61.19:5060;lr>

      07:07:14.553 SIP.STACK MSG         Supported: 100rel,replaces

      07:07:14.554 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

      07:07:14.555 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908_2nd_Gen/R12.3.1.E

      07:07:14.555 SIP.STACK MSG         Content-Type: application/sdp

      07:07:14.556 SIP.STACK MSG         Content-Length: 219

      07:07:14.556 SIP.STACK MSG    

      07:07:14.557 SIP.STACK MSG         v=0

      07:07:14.557 SIP.STACK MSG         o=- 43635 1 IN IP4 192.168.61.200

      07:07:14.558 SIP.STACK MSG         s=-

      07:07:14.558 SIP.STACK MSG         c=IN IP4 192.168.61.200

      07:07:14.559 SIP.STACK MSG         t=0 0

      07:07:14.560 SIP.STACK MSG         m=audio 10004 RTP/AVP 0 101

      07:07:14.560 SIP.STACK MSG         a=sendrecv

      07:07:14.561 SIP.STACK MSG         a=silenceSupp:off - - - -

      07:07:14.562 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

      07:07:14.562 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

      07:07:14.563 SIP.STACK MSG         a=fmtp:101 0-15

      07:07:14.563 SIP.STACK MSG    

      07:07:14.566 TM.T01 01 SipTM_Accept         call-leg -> Accepted

      07:07:14.567 TM.T01 01 SipTM_Accept         sent: 200 with SDP

      07:07:14.568 SA.2222222222 Ca:0 Connected            rcvd: AcctPhoneMgr_finalizeConnect from PM

      07:07:14.569 SA.2222222222 Ca:0 Connected            sent: finalizeConnect to SB

      07:07:14.569 SB.CALL 2 Connecting           Called the finalizeConnect routine

      07:07:14.570 SB.CALL 2 State change      >> Connecting->Connected

      07:07:14.592 SIP.STACK MSG     Rx: UDP src=192.168.61.19:5060 dst=192.168.61.200:5060

      07:07:14.593 SIP.STACK MSG         ACK sip:2222222222@192.168.61.200:5060;user=phone SIP/2.0

      07:07:14.594 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.19:5060;branch=z9hG4bK-00102-koh450dx2egzB94-102

      07:07:14.594 SIP.STACK MSG         Max-Forwards: 6

      07:07:14.595 SIP.STACK MSG         From: "City & State" <sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:07:14.595 SIP.STACK MSG         To: sip:2222222222@192.168.61.200:5060;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:07:14.596 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:07:14.597 SIP.STACK MSG         CSeq: 102 ACK

      07:07:14.597 SIP.STACK MSG         Content-Length: 0

      07:07:14.598 SIP.STACK MSG    

      07:07:14.601 SIP.STACK MSG Found existing transaction for the request message.

      07:07:14.602 TM.T01 01 SipTM_Accept         rcvd SIP call-leg request: ACK

      07:07:14.603 TM.T01 01 SipTM_Accept         call-leg -> Connected

      07:07:14.603 TM.T01 01 SipTM_Accept         No body in message when trying to get SDP

      07:07:14.604 TM.T01 01 SipTM_Accept         info: unable to save SDP

      07:07:14.605 TM.T01 01 SipTM_Accept         sent: TA->Connect

      07:07:14.605 TM.T01 01 SipTM_Accept         State change      >> SipTM_Accept->SipTM_Connected

      07:07:14.606 TM.T01 01 SipTM_Connected      call-leg-mod -> Modify Idle

      07:07:14.607 TA.T01 01 TAConnectPending     rcvd: connect from TM

      07:07:14.607 TA.T01 01 State change      >> rt (10006)

      07:07:14.675 SB.CCM translateAnswer: offer  codec list: PCMU PCMA G729

      07:07:14.676 SB.CCM                : answer codec list: PCMU

      07:07:14.677 SB.CCM translateAnswer: CODEC transcoding is not required

      07:07:14.678 SB.CCM translateAnswer: offer / answer DTMF signaling identical: DTMF transcoding not required

      07:07:14.680 SB.CCM translateAnswer: success

      07:07:14.681 MEDIA.MANAGER Allocating media port.

      07:07:14.682 MEDIA.MANAGER getSubstitutePort: Matching callIdMap entry found for call 3 sessionId -43636INIP4127.0.0.3 remote port 0

      07:07:14.683 MEDIA.MANAGER Call ID map : Added new session ID : call ID 3 : session -43636INIP4127.0.0.3 : version 2 : index 8

      07:07:14.684 MEDIA.MANAGER New media entry : type(0), callID(3), sessionID(-43636INIP4127.0.0.3), original IP(127.0.0.3) ports(10008-10009), substitute IP(::) ports(10008-10009), RtpChannel(0/1.1), connection(0x2903d10), sdpOverride(0), me(0x2905810). RtpChannel 0/1.1

      07:07:14.685 SB.CALL 3 State change      >> TransferUpdating->ReInvitingTransferConnecting

      07:07:14.686 SB.CALL 3 ReInvitingTransferConnecting Sent connect from 2222222222 to T01

      07:07:14.686 TA.T01 01 TAConnectWaitIn      connect event accepted

      07:07:14.687 TA.T01 01 State change      >> TAConnectWaitIn->TAConnectPending (TAS_Connected)

      07:07:14.687 TM.T01 01 SipTM_Connected      tachg -> TAConnectPending

      07:07:14.689 TM.T01 01 SipTM_Connected      sent: TA->Connect

      07:07:14.689 TA.T01 01 TAConnectPending     rcvd: connect from TM

      07:07:14.690 TA.T01 01 State change      >> TAConnectPending->TAConnected (TAS_Connected)

      07:07:14.690 SB.CALL 3 ReInvitingTransferConnecting Called the connectResponse routine

      07:07:14.691 SB.CCM connect:

      07:07:14.692 SB.CCM  :  Call Struct 0x31ea810 :   Call-ID = 3

      07:07:14.692 SB.CCM  :  Org Acct = T01    Dst Acct = 2222222222

      07:07:14.693 SB.CCM  :  Org Port ID = SipTrunk 0/0   Dst Port ID = FxsPhone 0/1

      07:07:14.693 SB.CCM  :  SDP Transaction = CallID: 3

      07:07:14.694 SB.CCM  :  SDP Offer = 0x02cf1610, ([::]:60000)

      07:07:14.695 SB.CCM  :  SDP Answer = 0x02905a10, (127.0.0.3:10008)

      07:07:14.696 SB.CCM  :  RTP Channel = 0/1.1

      07:07:14.696 SB.CCM connect: Call Connection Type is RTP_TO_TDM

      07:07:14.697 SB.CCM SDP offer is [::]:60000, SDP answer is 127.0.0.3:10008

      07:07:14.698 MEDIA.MANAGER Trying to connect call ID 3 : SDP sessions -43634INIP40.0.0.0 and -43636INIP4127.0.0.3

      07:07:14.700 MEDIA.MANAGER Found 1 ports for session -43634INIP40.0.0.0

      07:07:14.700 MEDIA.MANAGER Found 1 ports for session -43636INIP4127.0.0.3

      07:07:14.701 MEDIA.MANAGER Connecting Disconnected Local [::]:10006 : Remote [::]:60000

      07:07:14.702 MEDIA.MANAGER    and     Disconnected Local [::]:10008 : Remote 127.0.0.3:10008

      07:07:14.703 MEDIA.MANAGER Setting up DSP Media Connection 3 for entry(type(0), callID(3), sessionID(-43634INIP40.0.0.0), original IP(::) ports(60000-60001), substitute IP(::) ports(10006-10007), RtpChannel(0/1.1), connection(0x2cf1b10), sdpOverride(0), me(0x2cf1a10))

      07:07:14.704 MEDIA.MANAGER Setting up DSP Media Connection 3 for entry(type(0), callID(3), sessionID(-43636INIP4127.0.0.3), original IP(127.0.0.3) ports(10008-10009), substitute IP(::) ports(10008-10009), RtpChannel(0/1.1), connection(0x2903d10), sdpOverride(0), me(0x2905810))

      07:07:14.705 MEDIA.MANAGER Connection Fixup 1 DSP Port 10006

      07:07:14.705 MEDIA.MANAGER   Local [::]:10006 : Remote [::]:60000

      07:07:14.706 MEDIA.MANAGER Connection Fixup 2 DSP Port 10008

      07:07:14.706 MEDIA.MANAGER   Local [::]:10008 : Remote 127.0.0.3:10008

      07:07:14.707 MEDIA.MANAGER connectionFixup : Letting other side fixup connection : entry 10006 sub [::]:10006 remote [::]:60000

      07:07:14.708 MEDIA.MANAGER                 : Other side : entry 10008 sub [::]:10008 remote 127.0.0.3:10008

      07:07:14.708 MEDIA.MANAGER Connection Fixup 1 DSP Port 10008

      07:07:14.709 MEDIA.MANAGER   Local [::]:10008 : Remote 127.0.0.3:10008

      07:07:14.710 MEDIA.MANAGER Connection Fixup 2 DSP Port 10006

      07:07:14.710 MEDIA.MANAGER   Local [::]:10006 : Remote [::]:60000

      07:07:14.711 MEDIA.MANAGER connectionFixup : DSP media : Change entry 10008 remote from 127.0.0.3:10008 to [::]:60000

      07:07:14.711 MEDIA.MANAGER Setup RTP Channel false for 0/1.1

      07:07:14.712 MEDIA.MANAGER Setup RTP Channel true for 0/1.1

      07:07:14.713 MEDIA.MANAGER Connection Result 1 DSP Port 10008

      07:07:14.713 MEDIA.MANAGER   Local [::]:10008 : Remote [::]:60000

      07:07:14.714 MEDIA.MANAGER Connection Result 2 Entry not activated

      07:07:14.714 MEDIA.MANAGER connectionFixup success for port 10008 and 10006

      07:07:14.715 MEDIA.MANAGER Marking setup complete for port 10008

      07:07:14.715 MEDIA.MANAGER Marking setup complete for port 10006

      07:07:14.716 MEDIA.MANAGER Connection Fixup 1 DSP Port 10007

      07:07:14.717 MEDIA.MANAGER   Local [::]:10007 : Remote [::]:60001

      07:07:14.717 MEDIA.MANAGER Connection Fixup 2 DSP Port 10009

      07:07:14.718 MEDIA.MANAGER   Local [::]:10009 : Remote 127.0.0.3:10009

      07:07:14.718 MEDIA.MANAGER connectionFixup : Letting other side fixup connection : entry 10007 sub [::]:10007 remote [::]:60001

      07:07:14.720 MEDIA.MANAGER                 : Other side : entry 10009 sub [::]:10009 remote 127.0.0.3:10009

      07:07:14.721 MEDIA.MANAGER Connection Fixup 1 DSP Port 10009

      07:07:14.722 MEDIA.MANAGER   Local [::]:10009 : Remote 127.0.0.3:10009

      07:07:14.722 MEDIA.MANAGER Connection Fixup 2 DSP Port 10007

      07:07:14.723 MEDIA.MANAGER   Local [::]:10007 : Remote [::]:60001

      07:07:14.723 MEDIA.MANAGER connectionFixup : DSP media : Change entry 10009 remote from 127.0.0.3:10009 to [::]:60001

      07:07:14.724 MEDIA.MANAGER Connection Result 1 DSP Port 10009

      07:07:14.724 MEDIA.MANAGER   Local [::]:10009 : Remote [::]:60001

      07:07:14.725 MEDIA.MANAGER Connection Result 2 Entry not activated

      07:07:14.725 MEDIA.MANAGER connectionFixup success for port 10009 and 10007

      07:07:14.726 MEDIA.MANAGER Marking setup complete for port 10009

      07:07:14.727 MEDIA.MANAGER Marking setup complete for port 10007

      07:07:14.727 MEDIA.MANAGER Connected DSP Port 10008

      07:07:14.728 MEDIA.MANAGER   Local [::]:10008 : Remote [::]:60000

      07:07:14.729 MEDIA.MANAGER ConnecteCK MSG         t=0 0

      07:07:14.790 SIP.STACK MSG         m=audio 56466 RTP/AVP 0 101

      07:07:14.791 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

      07:07:14.792 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

      07:07:14.792 SIP.STACK MSG         a=fmtp:101 0-15

      07:07:14.793 SIP.STACK MSG         a=ptime:20

      07:07:14.793 SIP.STACK MSG         a=sendrecv

      07:07:14.794 SIP.STACK MSG    

      07:07:14.798 TM.T01 01 SipTM_ReInviting     rcvd SIP call-leg response: 200 OK

      07:07:14.799 TM.T01 01 SipTM_ReInviting     call-leg-mod -> Modify Re-Invite Remote Accepted

      07:07:14.800 TM.T01 01 SipTM_ReInviting     State change      >> SipTM_ReInviting->SipTM_ReInvitingPassed

      07:07:14.801 TM.T01 01 SipTM_ReInvitingPassed sent: TA->ReInvite Response - PASS

      07:07:14.802 TM.T01 01 SipTM_ReInvitingPassed sent: TA->ReConnect

      07:07:14.803 SB.CCM  :  Call Struct 0x31f1c10 :   Call-ID = 2

      07:07:14.804 SB.CCM  :  Org Acct = 8001    Dst Acct = 2222222222

      07:07:14.804 SB.CCM  :  Org Port ID = RingGroup 0/0   Dst Port ID = FxsPhone 0/1

      07:07:14.805 SB.CCM release: Call Connection Type is RG_TO_TDM

      07:07:14.806 SB.CALL 2 CallIdlePending      ClearResponse sent from 8001 to 2222222222

      07:07:14.806 TA.T01 01 TAReInvited          rcvd: reInviteResponse from TM

      07:07:14.807 TA.T01 01 TAReInvited          rcvd: reConnect from TM

      07:07:14.808 SB.CALL 3 ReInviteOrg          Called the reInviteResponse routine

      07:07:14.808 SB.CALL 3 ReInviteOrg          Called the reconnect routine

      07:07:14.809 SB.CCM isMappable:

      07:07:14.809 SB.CCM  :  Call Struct 0x31ea810 :   Call-ID = 3

      07:07:14.810 SB.CCM  :  Org Acct = T01    Dst Acct = 2222222222

      07:07:14.811 SB.CCM  :  Org Port ID = SipTrunk 0/1.1   Dst Port ID = FxsPhone 0/1

      07:07:14.811 SB.CCM  :  SDP Transaction = CallID: 3

      07:07:14.812 SB.CCM  :  SDP Offer = 0x02905310, (192.168.61.119:56466)

      07:07:14.813 SB.CCM  :  RTP Channel = 0/1.1

      07:07:14.813 SB.CCM isMappable: Call Connection Type is RTP_TO_TDM

      07:07:14.815 SB.CCM translateOffer: offer codec list: PCMU

      07:07:14.816 SB.CCM translateOffer: revised offer codec list: PCMU

      07:07:14.817 SB.CCM translateOffer: codec list after answerer: PCMU

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

      07:07:14.821 SB.CCM translateOffer: success

      07:07:14.822 MEDIA.MANAGER Allocating media port.

      07:07:14.822 MEDIA.MANAGER getSubstitutePort: Matching callIdMap entry found for call 3 sessionId -3044814INIP4192.168.61.19 remote port 56466

      07:07:14.823 MEDIA.MANAGER Call ID map : Added new session ID : call ID 3 : session -3044814INIP4192.168.61.19 : version 3044815 : index 10

      07:07:14.824 MEDIA.MANAGER New media entry : type(0), callID(3), sessionID(-3044814INIP4192.168.61.19), original IP(192.168.61.119) ports(56466-56467), substitute IP(::) ports(10010-10011), RtpChannel(0/1.1), connection(0x28f7110), sdpOverride(0), me(0x2900510). RtpChannel 0/1.1

      07:07:14.825 SB.CALL 3 ReInviteOrg          reInvite with SDP sent to 2222222222

      07:07:14.826 SB.CALL 3 State change      >> ReInviteOrg->ReInviteDst

      07:07:14.826 SA.2222222222 Ca:0 Connected            rcvd: reInvite from SB

      07:07:14.827 SA.2222222222 Ca:0 Connected            State change      >> Connected->ReinvitePending (CAS_Connected)

      07:07:14.828 SA.2222222222 Ca:0 ReinvitePending      sent: AcctPhoneMgr_reinvite to PM

      07:07:14.828 PM.0:1 Connected            Processed Reinvite Event pass

      07:07:14.829 SA.2222222222 Ca:0 ReinvitePending      rcvd: AcctPhoneMgr_Reinvite from PM

      07:07:14.829 SA.2222222222 Ca:0 ReinvitePending      sent: reinviteResponse(pass) to SB

      07:07:14.830 SA.2222222222 Ca:0 ReinvitePending      rcvd: AcctPhoneMgr_Reconnect from PM

      07:07:14.831 SA.2222222222 Ca:0 ReinvitePending      sent: reconnect to SB

      07:07:14.832 SA.2222222222 Ca:0 ReinvitePending      State change      >> ReinvitePending->ReconnectPending (CAS_Connected)

      07:07:14.832 SB.CALL 3 ReInviteDst          Called the reInviteResponse routine

      07:07:14.833 SB.CALL 3 ReInviteDst          Called the reconnect routine

      07:07:14.833 SB.CCM isResponseMappable:

      07:07:14.834 SB.CCM  :  Call Struct 0x31ea810 :   Call-ID = 3

      07:07:14.834 SB.CCM  :  Org Acct = T01    Dst Acct = 2222222222

      07:07:14.835 SB.CCM  :  Org Port ID = SipTrunk 0/1.1   Dst Port ID = FxsPhone 0/1

      07:07:14.836 SB.CCM  :  SDP Transaction = CallID: 3

      07:07:14.836 SB.CCM  :  SDP Offer = 0x02905310, (192.168.61.119:56466)

      07:07:14.837 SB.CCM  :  RTP Channel = 0/1.1

      07:07:14.838 SB.CCM isResponseMappable: reversing call connection type to compensate for event originator direction

      07:07:14.839 SB.CCM isResponseMappable: Call Connection Type is TDM_TO_RTP

      07:07:14.839 SB.CCM isResponseMappable: Creating SDP Answer based on SDP Offer

      07:07:14.840 SB.CCM createAnswer: creating SDP answer using RTP channel 0/1.1

      07:07:14.841 SB.CCM createAnswer : offer  codec list: PCMU

      07:07:14.842 SB.CCM              : answer codec list: PCMU

      07:07:14.846 SB.CCM createAnswer : result codec list: PCMU

      07:07:14.847 SB.CCM createAnswer : final DTMF signaling(NTE 101)

      07:07:14.848 MEDIA.MANAGER getSubstitutePort: Matching callIdMap entry found for call 3 sessionId -3044814INIP4192.168.61.19 remote port 56466

      07:07:14.848 MEDIA.MANAGER getSubstitutePort: Matching sessionPortMap entry found for session

      07:07:14.849 MEDIA.MANAGER getSubstitutePort: Session port count (1)  Returning port (10010)

      07:07:14.849 SB.CCM updateMediaEntryForReinviteWithSameSdp : no associated port found for port (10010)

      07:07:14.851 SB.CCM translateAnswer: offer  codec list: PCMU

      07:07:14.851 SB.CCM                : answer codec list: PCMU

      07:07:14.853 SB.CCM translateAnswer: CODEC transcoding is not required

      07:07:14.854 SB.CCM translateAnswer: offer / answer DTMF signaling identical: DTMF transcoding not required

      07:07:14.855 SB.CCM translateAnswer: success

      07:07:14.856 MEDIA.MANAGER Allocating media port.

      07:07:14.857 MEDIA.MANAGER getSubstitutePort: Matching callIdMap entry found for call 3 sessionId -43636INIP4127.0.0.3 remote port 0

      07:07:14.857 MEDIA.MANAGER getSubstitutePort: Matching sessi7:07:17.533 MEDIA.MANAGER Remove Call ID map entry for call 1

      07:07:17.533 MEDIA.MANAGER Remove Call ID map entry for call 2

      test#

      test#

      test#

      test#

      test#

      test#

      test#  Hook Flash event

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      07:08:15.120 PM.0:1 Connected            Processed flash hook

      07:08:15.121 PM.0:1 State change      >> Connected->Hold Pending

      07:08:15.121 SA.2222222222 Ca:0 Connected            rcvd: AcctPhoneMgr_hold(ON) from PM

      07:08:15.122 SA.2222222222 Ca:0 Connected            sent: hold(ON) to SB

      07:08:15.123 SA.2222222222 Ca:0 Connected            State change      >> Connected->HoldPending (CAS_Connected)

      07:08:15.123 SB.CCM isMappable:

      07:08:15.124 SB.CCM  :  Call Struct 0x31ea810 :   Call-ID = 3

      07:08:15.124 SB.CCM  :  Org Acct = T01    Dst Acct = 2222222222

      07:08:15.125 SB.CCM  :  Org Port ID = SipTrunk 0/1.1   Dst Port ID = FxsPhone 0/1

      07:08:15.126 SB.CCM  :  RTP Channel = 0/1.1

      07:08:15.126 SB.CCM isMappable: reversing call connection type to compensate for event originator direction

      07:08:15.127 SB.CCM isMappable: Call Connection Type is TDM_TO_RTP

      07:08:15.127 SB.CCM isMappable: Creating SDP Offer

      07:08:15.131 SB.CCM updateOfferWithEndpointConfig: DTMF(NTE 101), VAD(off), ptime(0)

      07:08:15.133 SB.CCM translateOffer: offer codec list: PCMU

      07:08:15.133 SB.CCM translateOffer: revised offer codec list: PCMU

      07:08:15.135 SB.CCM translateOffer: codec list after answerer: PCMU

      07:08:15.137 SB.CCM translateOffer: DTMF signaling: answerer has no restrictions configured, passing offer(NTE 101) through

      07:08:15.138 SB.CCM translateOffer: success

      07:08:15.139 MEDIA.MANAGER Allocating media port.

      07:08:15.139 MEDIA.MANAGER getSubstitutePort: Matching callIdMap entry found for call 3 sessionId -43636INIP4127.0.0.3 remote port 0

      07:08:15.140 MEDIA.MANAGER getSubstitutePort: Matching sessionPortMap entry found for session

      07:08:15.141 MEDIA.MANAGER getSubstitutePort: Session port count (1)  Returning port (10008)

      07:08:15.142 MEDIA.MANAGER Existing entry found for port reuse of SDP port 0 and sub port 10008.

      07:08:15.142 MEDIA.MANAGER Reuse media entry with updated SDP : call 3 : session -43636INIP4127.0.0.3 : remote IP 127.0.0.3 ports 10008 - 10009 : new :: ports 0 - 1.

      07:08:15.143 MEDIA.MANAGER Call ID map : Replacing with newer version : call ID 3 : session -43636INIP4127.0.0.3 : version 4 : index 8

      07:08:15.144 SB.CALL 3 Connected            Hold sent from 2222222222 to T01

      07:08:15.145 TA.T01 01 TAConnected          hold event accepted

      07:08:15.145 TM.T01 01 SipTM_Connected      State change      >> SipTM_Connected->SipTM_HoldFar

      07:08:15.146 TM.T01 01 SDP DPI call ID 3 : No media bin.

      07:08:15.147 TM.T01 01 Processing new SDP entries.

      07:08:15.148 TM.T01 01 Checking for internal Media Gateway IP Address

      07:08:15.148 TM.T01 01 RTP Channel is NULL, Media Gateway must not be involved in call

      07:08:15.149 TM.T01 01 Undo of previous operation not required (RTP NAT Entry for [::]:10008 not found)

      07:08:15.149 TM.T01 01 Checking for internal Media Gateway IP Address

      07:08:15.150 TM.T01 01 SDP has hold address

      07:08:15.155 SIP.STACK MSG     Tx: UDP src=192.168.61.200:5060 dst=192.168.61.19:5060

      07:08:15.156 SIP.STACK MSG         INVITE sip:192.168.61.19:5060 SIP/2.0

      07:08:15.156 SIP.STACK MSG         From: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:08:15.157 SIP.STACK MSG         To: "City & State"<sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:08:15.158 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:08:15.158 SIP.STACK MSG         CSeq: 2 INVITE

      07:08:15.159 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-1ee-78cf2-1d43f3fc

      07:08:15.159 SIP.STACK MSG         Max-Forwards: 70

      07:08:15.160 SIP.STACK MSG         Supported: 100rel,replaces

      07:08:15.161 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

      07:08:15.161 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908_2nd_Gen/R12.3.1.E

      07:08:15.163 SIP.STACK MSG         Contact: <sip:2222222222@192.168.61.200:5060;transport=UDP>

      07:08:15.163 SIP.STACK MSG         Route: <sip:1293172737@192.168.61.19:5060;lr>

      07:08:15.164 SIP.STACK MSG         Content-Type: application/sdp

      07:08:15.164 SIP.STACK MSG         Content-Length: 193

      07:08:15.165 SIP.STACK MSG    

      07:08:15.165 SIP.STACK MSG         v=0

      07:08:15.166 SIP.STACK MSG         o=- 43636 3 IN IP4 0.0.0.0

      07:08:15.166 SIP.STACK MSG         s=-

      07:08:15.167 SIP.STACK MSG         c=IN IP4 0.0.0.0

      07:08:15.168 SIP.STACK MSG         t=0 0

      07:08:15.168 SIP.STACK MSG         m=audio 10008 RTP/AVP 0 101

      07:08:15.169 SIP.STACK MSG         a=silenceSupp:off - - - -

      07:08:15.169 SIP.STACK MSG         a=rtpmap:0 PCMU/8000

      07:08:15.170 SIP.STACK MSG         a=rtpmap:101 telephone-event/8000

      07:08:15.170 SIP.STACK MSG         a=fmtp:101 0-15

      07:08:15.171 SIP.STACK MSG    

      07:08:15.173 TM.T01 01 SipTM_HoldFar        call-leg-mod -> Modify Re-Invite Sent

      07:08:15.174 TM.T01 01 SipTM_HoldFar        sent: re-INVITE

      07:08:15.179 SIP.STACK MSG     Rx: UDP src=192.168.61.19:5060 dst=192.168.61.200:5060

      07:08:15.179 SIP.STACK MSG         SIP/2.0 100 Trying

      07:08:15.180 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-1ee-78cf2-1d43f3fc

      07:08:15.181 SIP.STACK MSG         From: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:08:15.182 SIP.STACK MSG         To: "City & State" <sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:08:15.182 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:08:15.183 SIP.STACK MSG         CSeq: 2 INVITE

      07:08:15.184 SIP.STACK MSG         Content-Length: 0

      07:08:15.184 SIP.STACK MSG    

      07:08:15.187 TM.T01 01 SipTM_HoldFar        rcvd SIP call-leg response: 100 Trying

      07:08:15.188 TM.T01 01 SipTM_HoldFar        call-leg-mod -> Modify Re-Invite Proceeding

      07:08:19.183 SIP.STACK MSG     Rx: UDP src=192.168.61.19:5060 dst=192.168.61.200:5060

      07:08:19.184 SIP.STACK MSG         SIP/2.0 488 Not Acceptable Here

      07:08:19.184 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-1ee-78cf2-1d43f3fc

      07:08:19.185 SIP.STACK MSG         From: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:08:19.186 SIP.STACK MSG         To: "City & State" <sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:08:19.186 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:08:19.187 SIP.STACK MSG         CSeq: 2 INVITE

      07:08:19.187 SIP.STACK MSG         Content-Length: 0

      07:08:19.188 SIP.STACK MSG    

      07:08:19.191 TM.T01 01 SipTM_HoldFar        rcvd SIP call-leg response: 488 Not Acceptable Here

      07:08:19.192 TM.T01 01 SipTM_HoldFar        call-leg-mod -> Modify Re-Invite Response Rcvd

      07:08:19.192 TM.T01 01 SipTM_HoldFar        State change      >> SipTM_HoldFar->SipTM_HoldFarFailed

      07:08:19.193 TM.T01 01 SipTM_HoldFarFailed  sent: TA->Hold Response

      07:08:19.194 TM.T01 01 SipTM_HoldFarFailed  State change      >> SipTM_HoldFarFailed->SipTM_Connected

      07:08:19.197 SIP.STACK MSG     Tx: UDP src=192.168.61.200:5060 dst=192.168.61.19:5060

      07:08:19.198 SIP.STACK MSG         ACK sip:192.168.61.19:5060;transport=UDP SIP/2.0

      07:08:19.199 SIP.STACK MSG         From: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:08:19.199 SIP.STACK MSG         To: "City & State"<sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:08:19.200 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:08:19.201 SIP.STACK MSG         CSeq: 2 ACK

      07:08:19.201 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-1ee-78cf2-1d43f3fc

      07:08:19.202 SIP.STACK MSG         Max-Forwards: 70

      07:08:19.202 SIP.STACK MSG         Supported: 100rel,replaces

      07:08:19.203 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

      07:08:19.204 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908_2nd_Gen/R12.3.1.E

      07:08:19.204 SIP.STACK MSG         Contact: <sip:2222222222@192.168.61.200:5060;transport=UDP>

      07:08:19.205 SIP.STACK MSG         Route: <sip:1293172737@192.168.61.19:5060;lr>

      07:08:19.206 SIP.STACK MSG         Content-Length: 0

      07:08:19.206 SIP.STACK MSG    

      07:08:19.207 TM.T01 01 SipTM_Connected      call-leg-mod -> Modify Idle

      07:08:19.208 TA.T01 01 TAConnected          rcvd: holdResponse from TM

      07:08:19.209 SB.CALL 3 Connected            Called the holdResponse routine

      07:08:19.209 SB.CALL 3 Connected            ERROR! hold request failed

      07:08:19.210 SB.CALL 3 Connected            holdResponse sent from T01 to 2222222222

      07:08:19.211 SA.2222222222 Ca:0 HoldPending          rcvd: holdResponse from SB

      07:08:19.211 SA.2222222222 Ca:0 HoldPending          State change      >> HoldPending->Connected (CAS_Connected)

      07:08:19.212 SA.2222222222 Ca:0 Connected            sent: AcctPhoneMgr_holdResponse(fail) to PM

      07:08:19.213 PM.0:1 State change      >> Hold Pending->Connected

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#  Disconnect

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      test#

      07:08:57.646 PM.0:1 Connected            Processed ONHOOK

      07:08:57.646 PM.0:1 State change      >> Connected->Idle

      07:08:57.647 SA.2222222222 Ca:0 Connected            rcvd: AcctPhoneMgr_appearance(OFF) from PM

      07:08:57.647 SA.2222222222 Ca:0 Connected            sent: clearCall to SB

      07:08:57.648 SA.2222222222 Ca:0 Connected            State change      >> Connected->Clearing (CAS_Active)

      07:08:57.649 SA.2222222222 rcvd: AcctPhoneMgr_COSOverride from PM

      07:08:57.650 VOICE.SUMMARY Call from T01 to 2222222222 (2222222222) ended by 2222222222: normal clearing

      07:08:57.650 SB.CALL 3 Connected            Called the clearCall routine

      07:08:57.651 SB.CALL 3 Connected            ClearCall sent from 2222222222 to T01

      07:08:57.651 SB.CALL 3 State change      >> Connected->Clearing

      07:08:57.652 TA.T01 01 TAConnected          ClearCall event accepted

      07:08:57.653 TA.T01 01 State change      >> TAConnected->TAClearingComplete (TAS_Clearing)

      07:08:57.653 TM.T01 01 SipTM_Connected      tachg -> TAClearingComplete

      07:08:57.654 TM.T01 01 SipTM_Connected      tachgClearing caused transition to byeing state.

      07:08:57.655 TM.T01 01 SipTM_Connected      State change      >> SipTM_Connected->SipTM_Byeing

      07:08:57.658 SIP.STACK MSG     Tx: UDP src=192.168.61.200:5060 dst=192.168.61.19:5060

      07:08:57.659 SIP.STACK MSG         BYE sip:192.168.61.19:5060;transport=UDP SIP/2.0

      07:08:57.659 SIP.STACK MSG         From: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:08:57.661 SIP.STACK MSG         To: "City & State"<sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:08:57.661 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:08:57.662 SIP.STACK MSG         CSeq: 3 BYE

      07:08:57.662 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-219-832cb-e4461d0

      07:08:57.663 SIP.STACK MSG         Max-Forwards: 70

      07:08:57.664 SIP.STACK MSG         Supported: 100rel,replaces

      07:08:57.664 SIP.STACK MSG         Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

      07:08:57.665 SIP.STACK MSG         User-Agent: ADTRAN_Total_Access_908_2nd_Gen/R12.3.1.E

      07:08:57.666 SIP.STACK MSG         Route: <sip:1293172737@192.168.61.19:5060;lr>

      07:08:57.666 SIP.STACK MSG         Content-Length: 0

      07:08:57.667 SIP.STACK MSG    

      07:08:57.670 TM.T01 01 SipTM_Byeing         call-leg -> Disconnecting

      07:08:57.670 TM.T01 01 SipTM_Byeing         sent: BYE

      07:08:57.672 SB.CALL 3 Clearing             Called the clearResponse routine

      07:08:57.672 SB.CALL 3 State change      >> Clearing->CallIdlePending

      07:08:57.673 SB.CCM disconnect:

      07:08:57.673 SB.CCM  :  Call Struct 0x31ea810 :   Call-ID = 3

      07:08:57.674 SB.CCM  :  Org Acct = T01    Dst Acct = 2222222222

      07:08:57.675 SB.CCM  :  Org Port ID = SipTrunk 0/1.1   Dst Port ID = FxsPhone 0/1

      07:08:57.676 SB.CCM  :  RTP Channel = 0/1.1

      07:08:57.678 SIP.STACK MSG     Rx: UDP src=192.168.61.19:5060 dst=192.168.61.200:5060

      07:08:57.678 SIP.STACK MSG         SIP/2.0 200 OK

      07:08:57.679 SIP.STACK MSG         Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-219-832cb-e4461d0

      07:08:57.679 SIP.STACK MSG         From: <sip:2222222222@192.168.61.200:5060>;tag=319d0c8-7f000001-13c4-1a6-10188d3d-1a6

      07:08:57.680 SIP.STACK MSG         To: "City & State" <sip:1111111111@192.168.61.19:5060>;tag=koh450dx2egzB94-IPTrunk-1292-19-17at192.168.61.19

      07:08:57.681 SIP.STACK MSG         Call-ID: koh450dx2egzB94@192.168.61.19

      07:08:57.682 SIP.STACK MSG         CSeq: 3 BYE

      07:08:57.682 SIP.STACK MSG         Content-Length: 0

      07:08:57.683 SIP.STACK MSG    

      07:08:57.686 TM.T01 01 SipTM_Byeing         rcvd SIP call-leg response: 200 OK

      07:08:57.687 TM.T01 01 SipTM_Byeing         call-leg -> Disconnected

      07:08:57.687 TM.T01 01 SipTM_Byeing         State change      >> SipTM_Byeing->SipTM_Terminated

      07:08:57.688 TM.T01 01 SipTM_Terminated     sent: TA->AppearanceOff

      07:08:57.689 TM.T01 01 SipTM_Terminated     State change      >> SipTM_Terminated->SipTM_Idle

      07:08:57.690 SB.CCM disconnect: Call Connection Type is RTP_TO_TDM

      07:08:57.691 SB.CCM disconnect: Stopping RTP Channel 0/1.1

      07:08:57.692 RTP.CHANNEL Channel 0/1.1 stopped successfully.

      07:08:57.692 SB.CCM disconnect: Disconnecting TDM streams

      07:08:57.693 SB.CCM release:

      07:08:57.694 SB.CCM  :  Call Struct 0x31ea810 :   Call-ID = 3

      07:08:57.694 SB.CCM  :  Org Acct = T01    Dst Acct = 2222222222

      07:08:57.695 SB.CCM  :  Org Port ID = SipTrunk 0/1.1   Dst Port ID = FxsPhone 0/1

      07:08:57.695 SB.CCM  :  RTP Channel = 0/1.1

      07:08:57.696 SB.CCM release: Call Connection Type is RTP_TO_TDM

      07:08:57.697 SB.CCM release: Releasing RTP Channel 0/1.1

      07:08:57.697 RTP.CHANNEL RtpChannel::deallocate, status = 3, allocatedForInterface = 0

      07:08:57.698 RTP.CHANNEL Channel 0/1.1 released successfully.

      07:08:57.699 SB.CALL 3 CallIdlePending      ClearResponse sent from T01 to 2222222222

      07:08:57.699 SA.2222222222 Ca:0 Clearing             rcvd: clearResponse from SB

      07:08:57.700 SA.2222222222 Ca:0 Clearing             State change      >> Clearing->Idle (CAS_Idle)

      07:08:57.701 SA.2222222222 Ca:0 Idle                 sent: AcctPhoneMgr_cachg(CAS_Idle) to PM

      07:08:57.701 PM.0:1 Idle                 Dropped CACHG w/Call State not RINGING

      07:08:57.702 TA.T01 01 TAClearingComplete   rcvd: appearance off from TM

      07:08:57.703 TA.T01 01 TAClearingComplete   Clear Local Variables

      07:08:57.703 TA.T01 01 State change      >> TAClearingComplete->TAIdle (TAS_Idle)

      07:08:57.704 TM.T01 01 SipTM_Idle           tachg -> TAIdle

      07:08:57.705 RTP.CHANNEL fxs 0/1 - Dsp 0/1.1 - RTP: stopping

      07:08:57.706 RTP.CHANNEL fxs 0/1 - Dsp 0/1.1 - RTP: releasing RTP resource

      07:08:57.707 RTP.CHANNEL fxs 0/1 - Dsp 0/1.1 - RTP: releasing

      07:08:57 SB.CallStructObserver 3 Finalized

      1970.01.01 07:08:58 SMDR 3          01/01/1970 07:07:14      1.7 0    I  00/01 City & State 1111111111      00/01 Justin Tyme     2222222222      0 T 

      07:09:45.127 MEDIA.MANAGER Remove Call ID map entry for call 3

      test#

        • Re: Cannot transfer call to external number
          jayh Hall_of_Fame

          Your SIP server is rejecting the re-invite associated with the hookflash.

           

          See the following received message:

           

          07:08:19.183 SIP.STACK MSG     Rx: UDP src=192.168.61.19:5060 dst=192.168.61.200:5060

          07:08:19.184 SIP.STACK MSG         SIP/2.0 488 Not Acceptable Here

           

          Then the switchboard detects the failed re-invite and re-establishes the call:

           

          07:08:19.191 TM.T01 01 SipTM_HoldFar        rcvd SIP call-leg response: 488 Not Acceptable Here

          07:08:19.192 TM.T01 01 SipTM_HoldFar        call-leg-mod -> Modify Re-Invite Response Rcvd

          07:08:19.192 TM.T01 01 SipTM_HoldFar        State change      >> SipTM_HoldFar->SipTM_HoldFarFailed

           

          The next step would be to find out why the SIP server is rejecting the re-invite. It could be a SIP grammar issue, a feature that needs to be turned on, or something else. Logs from the SIP server will be useful.

            • Re: Cannot transfer call to external number
              triassicsoul1 New Member

              Thanks for helping me with this jayh

               

              The SIP trace from my Taqua switch is lacking SDP info from the IAD during the REinvite.  Specifically, there is no p=  telling the switch to place the call on hold or make inactive until bridged with a 3rd party.  And the SDP body is missing a codec.

               

              Is there a way to get the IAD to send this SDP info?

               

              Here is my SIP Trace output from my switch.  I copied just the part around the hookflash event...

               

              897.9183> |--- Start RX 901 bytes on FE-1-19-17 at [05/26/2017-12:14:17.880] from 192.168.61.200:5060 ---|

              INVITE sip:192.168.61.19:5060 SIP/2.0

              From: <sip:2222222222@192.168.61.200:5060>;tag=319d8e8-7f000001-13c4-2da-4fe84954-2da

              To: "City & State"<sip:1111111111@192.168.61.19:5060>;tag=RQh450cx2hgds0n-IPTrunk-867-19-17at192.168.61.19

              Call-ID: RQh450cx2hgds0n@192.168.61.19

              CSeq: 2 INVITE

              Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-30c-be739-22fe0032

              Max-Forwards: 70

              Supported: 100rel,replaces

              Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER

              User-Agent: ADTRAN_Total_Access_908_2nd_Gen/R12.3.1.E

              Contact: <sip:2222222222@192.168.61.200:5060;transport=UDP>

              Route: <sip:1293172737@192.168.61.19:5060;lr>

              Content-Type: application/sdp

              Content-Length: 193

               

              v=0

              o=- 43946 3 IN IP4 0.0.0.0

              s=-

              c=IN IP4 0.0.0.0

              t=0 0

              m=audio 10020 RTP/AVP 0 101

              a=silenceSupp:off - - - -

              a=rtpmap:0 PCMU/8000

              a=rtpmap:101 telephone-event/8000

              a=fmtp:101 0-15

               

              |--- End of message received from the network ---|

               

              |--- Start TX 368 bytes on FE-1-19-17 at [05/26/2017-12:14:17.892] to 192.168.61.200:5060 ---|

              SIP/2.0 100 Trying

              Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-30c-be739-22fe0032

              TRACE[05/26/2017-12:14:17.894] (tSignaling - 867) : ReINVITEprocedure processing in stable call state

              TRACE[05/26/2017-12:14:17.894] SRC:0x3f-> (tSignaling - 867) -> (transferIndicate) [connected :: connected]

              TRACE[05/26/2017-12:14:17.895] SRC:0x3f-> (tSignaling - 867) -> (recvREINVITE) [connected :: midCallReqRcvd]

              From: <sip:2222222222@192.168.61.200:5060>;tag=319d8e8-7f000001-13c4-2da-4fe84954-2da

              To: "City & State" <sip:1111111111@192.168.61.19:5060>;tag=RQh450cx2hgds0n-IPTrunk-867-19-17at192.168.61.19

              Call-ID: RQh450cx2hgds0n@192.168.61.19

              CSeq: 2 INVITE

              Content-Length: 0

               

               

              |--- End of message sent to the network ---|

               

              TRACE[05/26/2017-12:14:17.900] SRC:0x3f-> (tSignaling - 867) -> (protocolServiceRsp) [midCallReqRcvd :: midCallReqRcvd]

              TRACE[05/26/2017-12:14:21.900] (tSignaling - 867) : process ReINVITE protocolServiceRsp reasonCode = 3

              TRACE[05/26/2017-12:14:21.900] SRC:0x3f-> (tSignaling - 867) -> (protocolServiceRsp) [midCallReqRcvd :: midCallReqRcvd]

              |--- Start TX 381 bytes on FE-1-19-17 at [05/26/2017-12:14:21.901] to 192.168.61.200:5060 ---|

              SIP/2.0 488 Not Acceptable Here

              Via: SIP/2.0/UDP 192.168.61.200:5060;branch=z9hG4bK-30c-be739-22fe0032

              From: <sip:2222222222@192.168.61.200:5060>;tag=319d8e8-7f000001-13c4-2da-4fe84954-2da

              To: "City & State" <sip:1111111111@192.168.61.19:5060>;tag=RQh450cx2hgds0n-IPTrunk-867-19-17at192.168.61.19

              Call-ID: RQh450cx2hgds0n@192.168.61.19

              CSeq: 2 INVITE

              Content-Length: 0

               

               

              |--- End of message sent to the network ---|

                • Re: Cannot transfer call to external number
                  jayh Hall_of_Fame

                  Have you asked Taqua if they have an interop guide for Adtran?

                   

                  There are a couple of things you can try. First, try disabling the double-renivite and tweaking the SDP.

                   

                  voice trunk T01

                    no prefer double-reinvite

                   

                  Also this may help:

                   

                  voice trunk T01

                    no prefer reinvite-without-sdp

                   

                  Another option is to handle the transfer function locally rather than on the softswitch.

                   

                  voice transfer-mode local

                   

                  is the command. Default is

                   

                  voice transfer-mode network

                    • Re: Cannot transfer call to external number
                      triassicsoul1 New Member

                      I have asked Taqua for an Interop Guide (if one exists).

                       

                      Meanwhile, I have tried many different scenarios.  I have tried "transfer-mode = {local and network}".  I have tried disabling the double-reinvite and reinvite-without-sdp as you suggested above (separately and together).  A friend at another telco shared his TA900 config and that config is producing the same results on my switch (and he has the same switch I have).  I'll update again after I try a few more things.