Hi all, One of our locations is having issues placing outgoing calls to external numbers. The issue happens several times on and off throughout the day, every day. It lasts for about 20 minutes average before calls can be placed again. It has been ongoing for a couple of weeks now. Carrier obtained call samples we provided and said that none of them made it to the SIP Gateway that interfaces with our PBX; so basically they said the issue is on our side because they cannot find the calls on the SIP Gateway. When debugging the unit using Voice Summary I see the call attempting to route out through the SIP Trunk going to the carrier and it gives a "Temporary Failure" message. A debug using Voice Verbose and SIP Stack Messages shows "Temporary Failure", "No available resources on call from 6969 to T10 " and "Call Failed: rejecting with 503, result = 1". What could possibly be going wrong here? No problems placing calls EXT to EXT or incoming calls. Debug attached. Calling number: 830-775-1272 EXT:6969 Dialed Number: 830-765-4768 Thx.
Aaron,
You need to tell your provider "Spectrum" that they are not responding to our SIP messages.
If you look at debug below we send invite at 9:47:52:472, then we send second INVITE at 52:979 .5 ms later, then we send 3rd invite at 53.986 1.5sec after 2nd. then we time out with our default timer at 3 seconds at 55:482 . call fails so we send back a 503 serv unavail to the local phone which is normal.
So you need to ask them why they aren't responding to our messages? Let me know if you need any further info.
9:47:52.472 SIP.STACK MSG Tx: UDP src=10.59.26.1:5060 dst=10.59.26.2:5060
09:47:52.472 SIP.STACK MSG INVITE sip:7654768@10.59.26.2:5060 SIP/2.0
09:47:52.473 SIP.STACK MSG From: 'Test ' <sip:6969@10.59.26.2:5060;transport=UDP>;tag=5b64f20-a3b0601-13c4-d13e-99b91cba-d13e
09:47:52.473 SIP.STACK MSG To: <sip:7654768@10.59.26.2:5060>
09:47:52.473 SIP.STACK MSG Call-ID: 5bbd9f0-a3b0601-13c4-d13e-840a3781-d13e@10.59.26.2
09:47:52.473 SIP.STACK MSG CSeq: 1 INVITE
09:47:52.473 SIP.STACK MSG Via: SIP/2.0/UDP 10.59.26.1:5060;branch=z9hG4bK-d13e-3315cea-4dfea095
09:47:52.474 SIP.STACK MSG Max-Forwards: 70
09:47:52.474 SIP.STACK MSG Supported: 100rel,replaces
09:47:52.474 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
09:47:52.474 SIP.STACK MSG User-Agent: ADTRAN_NetVanta_7100/R11.10.4.E
09:47:52.474 SIP.STACK MSG Contact: <sip:6969@10.59.26.1:5060;transport=UDP>
09:47:52.475 SIP.STACK MSG Content-Type: application/sdp
09:47:52.475 SIP.STACK MSG Content-Length: 350
09:47:52.475 SIP.STACK MSG
09:47:52.475 SIP.STACK MSG v=0
09:47:52.475 SIP.STACK MSG o=3cxVCE 92587500 261800415 IN IP4 10.59.7.77
09:47:52.476 SIP.STACK MSG s=3cxVCE Audio Call
09:47:52.476 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.476 SIP.STACK MSG t=0 0
09:47:52.476 SIP.STACK MSG m=audio 40042 RTP/AVP 0 101
09:47:52.476 SIP.STACK MSG a=ptime:20
09:47:52.477 SIP.STACK MSG a=sendrecv
09:47:52.477 SIP.STACK MSG a=rtpmap:0 PCMU/8000
09:47:52.477 SIP.STACK MSG a=rtpmap:101 telephone-event/8000
09:47:52.477 SIP.STACK MSG a=fmtp:101 0-15
09:47:52.477 SIP.STACK MSG m=video 40040 RTP/AVP 34
09:47:52.478 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.478 SIP.STACK MSG a=rtpmap:34 H263/90000
09:47:52.478 SIP.STACK MSG a=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1
09:47:52.479 SIP.STACK MSG a=sendrecv
09:47:52.479 SIP.STACK MSG
09:47:52.480 SIP.CLDU Cldu::CallLegStateChangedEv: (0x5bbd9f0)->Inviting
09:47:52.480 TM.T10 05 Delivering call-leg -> Inviting
09:47:52.480 TM.T10 05 Delivering sent: INVITE
09:47:52.481 SB.CALL 314 Delivering Called the deliverResponse routine from Delivering
09:47:52.481 SB.CALL 314 Delivering DeliverResponse(accept) sent from T10 to 6969
09:47:52.481 SA.6969 Ca:0 Calling rcvd: deliverResponse from SB
09:47:52.482 SA.6969 Ca:0 Calling sent: AcctPhoneMgr_info to PM
09:47:52.482 PM.6969 Ca:0 SipPM_Pending warn: AcctPhoneMgr_info
09:47:52.979 SIP.STACK MSG SIP stack timer retransmit
09:47:52.979 SIP.STACK MSG Tx: UDP src=10.59.26.1:5060 dst=10.59.26.2:5060
09:47:52.979 SIP.STACK MSG INVITE sip:7654768@10.59.26.2:5060 SIP/2.0
09:47:52.979 SIP.STACK MSG From: 'Test ' <sip:6969@10.59.26.2:5060;transport=UDP>;tag=5b64f20-a3b0601-13c4-d13e-99b91cba-d13e
09:47:52.980 SIP.STACK MSG To: <sip:7654768@10.59.26.2:5060>
09:47:52.980 SIP.STACK MSG Call-ID: 5bbd9f0-a3b0601-13c4-d13e-840a3781-d13e@10.59.26.2
09:47:52.980 SIP.STACK MSG CSeq: 1 INVITE
09:47:52.980 SIP.STACK MSG Via: SIP/2.0/UDP 10.59.26.1:5060;branch=z9hG4bK-d13e-3315cea-4dfea095
09:47:52.981 SIP.STACK MSG Max-Forwards: 70
09:47:52.981 SIP.STACK MSG Supported: 100rel,replaces
09:47:52.981 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
09:47:52.981 SIP.STACK MSG User-Agent: ADTRAN_NetVanta_7100/R11.10.4.E
09:47:52.981 SIP.STACK MSG Contact: <sip:6969@10.59.26.1:5060;transport=UDP>
09:47:52.982 SIP.STACK MSG Content-Type: application/sdp
09:47:52.982 SIP.STACK MSG Content-Length: 350
09:47:52.982 SIP.STACK MSG
09:47:52.982 SIP.STACK MSG v=0
09:47:52.982 SIP.STACK MSG o=3cxVCE 92587500 261800415 IN IP4 10.59.7.77
09:47:52.983 SIP.STACK MSG s=3cxVCE Audio Call
09:47:52.983 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.983 SIP.STACK MSG t=0 0
09:47:52.983 SIP.STACK MSG m=audio 40042 RTP/AVP 0 101
09:47:52.983 SIP.STACK MSG a=ptime:20
09:47:52.984 SIP.STACK MSG a=sendrecv
09:47:52.984 SIP.STACK MSG a=rtpmap:0 PCMU/8000
09:47:52.984 SIP.STACK MSG a=rtpmap:101 telephone-event/8000
09:47:52.984 SIP.STACK MSG a=fmtp:101 0-15
09:47:52.985 SIP.STACK MSG m=video 40040 RTP/AVP 34
09:47:52.985 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.985 SIP.STACK MSG a=rtpmap:34 H263/90000
09:47:52.985 SIP.STACK MSG a=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1
09:47:52.986 SIP.STACK MSG a=sendrecv
09:47:52.986 SIP.STACK MSG
09:47:53.986 SIP.STACK MSG SIP stack timer retransmit
09:47:53.986 SIP.STACK MSG Tx: UDP src=10.59.26.1:5060 dst=10.59.26.2:5060
09:47:53.987 SIP.STACK MSG INVITE sip:7654768@10.59.26.2:5060 SIP/2.0
09:47:53.987 SIP.STACK MSG From: 'Test ' <sip:6969@10.59.26.2:5060;transport=UDP>;tag=5b64f20-a3b0601-13c4-d13e-99b91cba-d13e
09:47:53.987 SIP.STACK MSG To: <sip:7654768@10.59.26.2:5060>
09:47:53.987 SIP.STACK MSG Call-ID: 5bbd9f0-a3b0601-13c4-d13e-840a3781-d13e@10.59.26.2
09:47:53.987 SIP.STACK MSG CSeq: 1 INVITE
09:47:53.988 SIP.STACK MSG Via: SIP/2.0/UDP 10.59.26.1:5060;branch=z9hG4bK-d13e-3315cea-4dfea095
09:47:53.988 SIP.STACK MSG Max-Forwards: 70
09:47:53.988 SIP.STACK MSG Supported: 100rel,replaces
09:47:53.988 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
09:47:53.989 SIP.STACK MSG User-Agent: ADTRAN_NetVanta_7100/R11.10.4.E
09:47:53.989 SIP.STACK MSG Contact: <sip:6969@10.59.26.1:5060;transport=UDP>
09:47:53.989 SIP.STACK MSG Content-Type: application/sdp
09:47:53.989 SIP.STACK MSG Content-Length: 350
09:47:53.990 SIP.STACK MSG
09:47:53.990 SIP.STACK MSG v=0
09:47:53.990 SIP.STACK MSG o=3cxVCE 92587500 261800415 IN IP4 10.59.7.77
09:47:53.990 SIP.STACK MSG s=3cxVCE Audio Call
09:47:53.990 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:53.991 SIP.STACK MSG t=0 0
09:47:53.991 SIP.STACK MSG m=audio 40042 RTP/AVP 0 101
09:47:53.991 SIP.STACK MSG a=ptime:20
09:47:53.991 SIP.STACK MSG a=sendrecv
09:47:53.992 SIP.STACK MSG a=rtpmap:0 PCMU/8000
09:47:53.992 SIP.STACK MSG a=rtpmap:101 telephone-event/8000
09:47:53.992 SIP.STACK MSG a=fmtp:101 0-15
09:47:53.992 SIP.STACK MSG m=video 40040 RTP/AVP 34
09:47:53.992 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:53.993 SIP.STACK MSG a=rtpmap:34 H263/90000
09:47:53.993 SIP.STACK MSG a=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1
09:47:53.993 SIP.STACK MSG a=sendrecv
09:47:53.993 SIP.STACK MSG
09:47:55.482 TM.T10 05 INVITE rollover timeout
09:47:55.482 TM.T10 05 Delivering Sip_CreateCallLegNextServer (outbound proxy) with default validator
09:47:55.483 TM.T10 05 Delivering State change >> Delivering->SipTM_Closing
09:47:55.483 TM.T10 05 SipTM_Closing sent: TA->Clear
09:47:55.483 SIP.CLDU Cldu::CallLegStateChangedEv: (0x5bbd9f0)->Terminated
Aaron,
We receive the invite then we forward the invite to 10.59.26.2 three times out T10, then it times out after 3 seconds because we never receive a 100 TRYING back. what is 10.59.26.2?
15:04:19.099 SIP.STACK MSG Tx: UDP src=10.59.26.1:5060 dst=10.59.26.2:5060
15:04:19.099 SIP.STACK MSG INVITE sip:7654768@10.59.26.2:5060 SIP/2.0
Can you attach your config?
Also do another call with following debug:
debug sip stack messages
debug sip cldu
debug voice verbose
Thanks,
Mark
Aaron,
You need to tell your provider "Spectrum" that they are not responding to our SIP messages.
If you look at debug below we send invite at 9:47:52:472, then we send second INVITE at 52:979 .5 ms later, then we send 3rd invite at 53.986 1.5sec after 2nd. then we time out with our default timer at 3 seconds at 55:482 . call fails so we send back a 503 serv unavail to the local phone which is normal.
So you need to ask them why they aren't responding to our messages? Let me know if you need any further info.
9:47:52.472 SIP.STACK MSG Tx: UDP src=10.59.26.1:5060 dst=10.59.26.2:5060
09:47:52.472 SIP.STACK MSG INVITE sip:7654768@10.59.26.2:5060 SIP/2.0
09:47:52.473 SIP.STACK MSG From: 'Test ' <sip:6969@10.59.26.2:5060;transport=UDP>;tag=5b64f20-a3b0601-13c4-d13e-99b91cba-d13e
09:47:52.473 SIP.STACK MSG To: <sip:7654768@10.59.26.2:5060>
09:47:52.473 SIP.STACK MSG Call-ID: 5bbd9f0-a3b0601-13c4-d13e-840a3781-d13e@10.59.26.2
09:47:52.473 SIP.STACK MSG CSeq: 1 INVITE
09:47:52.473 SIP.STACK MSG Via: SIP/2.0/UDP 10.59.26.1:5060;branch=z9hG4bK-d13e-3315cea-4dfea095
09:47:52.474 SIP.STACK MSG Max-Forwards: 70
09:47:52.474 SIP.STACK MSG Supported: 100rel,replaces
09:47:52.474 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
09:47:52.474 SIP.STACK MSG User-Agent: ADTRAN_NetVanta_7100/R11.10.4.E
09:47:52.474 SIP.STACK MSG Contact: <sip:6969@10.59.26.1:5060;transport=UDP>
09:47:52.475 SIP.STACK MSG Content-Type: application/sdp
09:47:52.475 SIP.STACK MSG Content-Length: 350
09:47:52.475 SIP.STACK MSG
09:47:52.475 SIP.STACK MSG v=0
09:47:52.475 SIP.STACK MSG o=3cxVCE 92587500 261800415 IN IP4 10.59.7.77
09:47:52.476 SIP.STACK MSG s=3cxVCE Audio Call
09:47:52.476 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.476 SIP.STACK MSG t=0 0
09:47:52.476 SIP.STACK MSG m=audio 40042 RTP/AVP 0 101
09:47:52.476 SIP.STACK MSG a=ptime:20
09:47:52.477 SIP.STACK MSG a=sendrecv
09:47:52.477 SIP.STACK MSG a=rtpmap:0 PCMU/8000
09:47:52.477 SIP.STACK MSG a=rtpmap:101 telephone-event/8000
09:47:52.477 SIP.STACK MSG a=fmtp:101 0-15
09:47:52.477 SIP.STACK MSG m=video 40040 RTP/AVP 34
09:47:52.478 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.478 SIP.STACK MSG a=rtpmap:34 H263/90000
09:47:52.478 SIP.STACK MSG a=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1
09:47:52.479 SIP.STACK MSG a=sendrecv
09:47:52.479 SIP.STACK MSG
09:47:52.480 SIP.CLDU Cldu::CallLegStateChangedEv: (0x5bbd9f0)->Inviting
09:47:52.480 TM.T10 05 Delivering call-leg -> Inviting
09:47:52.480 TM.T10 05 Delivering sent: INVITE
09:47:52.481 SB.CALL 314 Delivering Called the deliverResponse routine from Delivering
09:47:52.481 SB.CALL 314 Delivering DeliverResponse(accept) sent from T10 to 6969
09:47:52.481 SA.6969 Ca:0 Calling rcvd: deliverResponse from SB
09:47:52.482 SA.6969 Ca:0 Calling sent: AcctPhoneMgr_info to PM
09:47:52.482 PM.6969 Ca:0 SipPM_Pending warn: AcctPhoneMgr_info
09:47:52.979 SIP.STACK MSG SIP stack timer retransmit
09:47:52.979 SIP.STACK MSG Tx: UDP src=10.59.26.1:5060 dst=10.59.26.2:5060
09:47:52.979 SIP.STACK MSG INVITE sip:7654768@10.59.26.2:5060 SIP/2.0
09:47:52.979 SIP.STACK MSG From: 'Test ' <sip:6969@10.59.26.2:5060;transport=UDP>;tag=5b64f20-a3b0601-13c4-d13e-99b91cba-d13e
09:47:52.980 SIP.STACK MSG To: <sip:7654768@10.59.26.2:5060>
09:47:52.980 SIP.STACK MSG Call-ID: 5bbd9f0-a3b0601-13c4-d13e-840a3781-d13e@10.59.26.2
09:47:52.980 SIP.STACK MSG CSeq: 1 INVITE
09:47:52.980 SIP.STACK MSG Via: SIP/2.0/UDP 10.59.26.1:5060;branch=z9hG4bK-d13e-3315cea-4dfea095
09:47:52.981 SIP.STACK MSG Max-Forwards: 70
09:47:52.981 SIP.STACK MSG Supported: 100rel,replaces
09:47:52.981 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
09:47:52.981 SIP.STACK MSG User-Agent: ADTRAN_NetVanta_7100/R11.10.4.E
09:47:52.981 SIP.STACK MSG Contact: <sip:6969@10.59.26.1:5060;transport=UDP>
09:47:52.982 SIP.STACK MSG Content-Type: application/sdp
09:47:52.982 SIP.STACK MSG Content-Length: 350
09:47:52.982 SIP.STACK MSG
09:47:52.982 SIP.STACK MSG v=0
09:47:52.982 SIP.STACK MSG o=3cxVCE 92587500 261800415 IN IP4 10.59.7.77
09:47:52.983 SIP.STACK MSG s=3cxVCE Audio Call
09:47:52.983 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.983 SIP.STACK MSG t=0 0
09:47:52.983 SIP.STACK MSG m=audio 40042 RTP/AVP 0 101
09:47:52.983 SIP.STACK MSG a=ptime:20
09:47:52.984 SIP.STACK MSG a=sendrecv
09:47:52.984 SIP.STACK MSG a=rtpmap:0 PCMU/8000
09:47:52.984 SIP.STACK MSG a=rtpmap:101 telephone-event/8000
09:47:52.984 SIP.STACK MSG a=fmtp:101 0-15
09:47:52.985 SIP.STACK MSG m=video 40040 RTP/AVP 34
09:47:52.985 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:52.985 SIP.STACK MSG a=rtpmap:34 H263/90000
09:47:52.985 SIP.STACK MSG a=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1
09:47:52.986 SIP.STACK MSG a=sendrecv
09:47:52.986 SIP.STACK MSG
09:47:53.986 SIP.STACK MSG SIP stack timer retransmit
09:47:53.986 SIP.STACK MSG Tx: UDP src=10.59.26.1:5060 dst=10.59.26.2:5060
09:47:53.987 SIP.STACK MSG INVITE sip:7654768@10.59.26.2:5060 SIP/2.0
09:47:53.987 SIP.STACK MSG From: 'Test ' <sip:6969@10.59.26.2:5060;transport=UDP>;tag=5b64f20-a3b0601-13c4-d13e-99b91cba-d13e
09:47:53.987 SIP.STACK MSG To: <sip:7654768@10.59.26.2:5060>
09:47:53.987 SIP.STACK MSG Call-ID: 5bbd9f0-a3b0601-13c4-d13e-840a3781-d13e@10.59.26.2
09:47:53.987 SIP.STACK MSG CSeq: 1 INVITE
09:47:53.988 SIP.STACK MSG Via: SIP/2.0/UDP 10.59.26.1:5060;branch=z9hG4bK-d13e-3315cea-4dfea095
09:47:53.988 SIP.STACK MSG Max-Forwards: 70
09:47:53.988 SIP.STACK MSG Supported: 100rel,replaces
09:47:53.988 SIP.STACK MSG Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
09:47:53.989 SIP.STACK MSG User-Agent: ADTRAN_NetVanta_7100/R11.10.4.E
09:47:53.989 SIP.STACK MSG Contact: <sip:6969@10.59.26.1:5060;transport=UDP>
09:47:53.989 SIP.STACK MSG Content-Type: application/sdp
09:47:53.989 SIP.STACK MSG Content-Length: 350
09:47:53.990 SIP.STACK MSG
09:47:53.990 SIP.STACK MSG v=0
09:47:53.990 SIP.STACK MSG o=3cxVCE 92587500 261800415 IN IP4 10.59.7.77
09:47:53.990 SIP.STACK MSG s=3cxVCE Audio Call
09:47:53.990 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:53.991 SIP.STACK MSG t=0 0
09:47:53.991 SIP.STACK MSG m=audio 40042 RTP/AVP 0 101
09:47:53.991 SIP.STACK MSG a=ptime:20
09:47:53.991 SIP.STACK MSG a=sendrecv
09:47:53.992 SIP.STACK MSG a=rtpmap:0 PCMU/8000
09:47:53.992 SIP.STACK MSG a=rtpmap:101 telephone-event/8000
09:47:53.992 SIP.STACK MSG a=fmtp:101 0-15
09:47:53.992 SIP.STACK MSG m=video 40040 RTP/AVP 34
09:47:53.992 SIP.STACK MSG c=IN IP4 10.59.7.77
09:47:53.993 SIP.STACK MSG a=rtpmap:34 H263/90000
09:47:53.993 SIP.STACK MSG a=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1
09:47:53.993 SIP.STACK MSG a=sendrecv
09:47:53.993 SIP.STACK MSG
09:47:55.482 TM.T10 05 INVITE rollover timeout
09:47:55.482 TM.T10 05 Delivering Sip_CreateCallLegNextServer (outbound proxy) with default validator
09:47:55.483 TM.T10 05 Delivering State change >> Delivering->SipTM_Closing
09:47:55.483 TM.T10 05 SipTM_Closing sent: TA->Clear
09:47:55.483 SIP.CLDU Cldu::CallLegStateChangedEv: (0x5bbd9f0)->Terminated
Thank you. I'll update once I hear back from them.
This is just an educated guess but it looks like you are sending an internal 4 digit extension for your digit out pulse. Most providers require you to out pulse a 10 digit number assigned to that trunk. You can do a match replace on trunk 10 the same way you have on trunk 4.
match dnis $ replace ani 830-775-1272
John Wable
It was a challenge getting them to fix it but it did turn out to be something misconfigured on their end. Thank you.
Glad to hear you got it worked out. Thanks for the update!