• V20: 3CX Re-engineered. Get V20 for increased security, better call management, a new admin console and Windows softphone. Learn More.

All Circuits Are Busy Intercept

Status
Not open for further replies.

SIPfun

Joined
Jun 23, 2008
Messages
56
Reaction score
0
I may have changed a couple things... Things died - and I started trying all kinds of different router settings...

I can dial INTO my PBX from the outside world via VOIP... I see the call come into the phone system... but as soon as anything answers the call fails... The caller gets an interrupt and I can't tell if it's the VOIP provider or the PBX...

[MS105000] C:102.1: No RTP packets were received:remoteAddr=147.135.20.250:19186,extAddr=199.232.75.181:9014,localAddr=199.232.75.181:9014
[CM503008]: Call(102): Call is terminated
[CM503012]: Inbound office hours' rule for LN:10000 forwards to DN:150

So here you can see the call come in on extension (VOIP) line 10000, and rings extension (150) -- which is does ring the phone.

No RTP packets... I'm guessing that's the issue... So are there specific port forwarding I should look at??? Also - MS Live Mesh got installed on the PBX box (for remote admin)... I didn't notice an exact time/relationship to the failures - but maybe Mesh is grabbing traffic???

Any thoughts?
 
Hi

Do you manage to make outbound calls? Do they fail the same way?

Ensure you have set up port mapping as explained in http://www.3cx.com/support/nat-firewalls.html

If you suspect MS Live mesh is interfering, you might try to disable it to see if it still persists with the issue.

If the issue remains even with MS live mesh and the port mapping done correctly, it is recommended you submit the 3CX verbose logs so we could see what is exactly happening.
 
I'll triple check the port forwarding...

I make outgoing calls without issue.
 
10:30:22.718 MediaServerReporting::RTPReceiver [MS105000] C:5.1: No RTP packets were received:remoteAddr=147.135.20.248:11178,extAddr=199.232.75.181:9008,localAddr=199.232.75.181:9008
10:30:22.609 Call::Terminate [CM503008]: Call(5): Call is terminated
10:30:22.593 Call::Terminate [CM503008]: Call(5): Call is terminated
10:30:22.593 LineCfg::getInboundTarget [CM503012]: Inbound office hours' rule for LN:10000 forwards to DN:801
10:30:22.593 Call::Terminate [CM503008]: Call(5): Call is terminated
10:30:22.593 LineCfg::getInboundTarget [CM503012]: Inbound office hours' rule for LN:10000 forwards to DN:801
10:30:22.578 LineCfg::getInboundTarget [CM503012]: Inbound office hours' rule for LN:10000 forwards to DN:801
10:30:22.578 InviteADS::eek:nAckNotReceived [CM503019]: Call(5): ACK is not received
10:29:50.546 CallCtrl::eek:nLegConnected [CM503007]: Call(5): Device joined: sip:[email protected]:40600;rinstance=0331b340a758b641
10:29:50.546 LineCfg::getInboundTarget [CM503012]: Inbound office hours' rule for LN:10000 forwards to DN:801
10:29:50.546 CallCtrl::eek:nLegConnected [CM503007]: Call(5): Device joined: sip:[email protected]:5060
10:29:50.531 Extension::printEndpointInfo [CM505001]: Ext.801: Device info: Device Identified: [Man: 3CX Ltd.;Mod: 3CX IVR;Rev: 1] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX IVR] Transport: [sip:127.0.0.1:5060]
10:29:50.531 CallCtrl::eek:nAnsweredCall [CM503002]: Call(5): Alerting sip:[email protected]:40600;rinstance=0331b340a758b641
10:29:50.031 CallCtrl::eek:nSelectRouteReq [CM503004]: Call(5): Calling: Ext:Ext.801@[Dev:sip:[email protected]:40600;rinstance=0331b340a758b641]
10:29:50.031 CallCtrl::eek:nSelectRouteReq [CM503010]: Making route(s) to [sip:[email protected]:5060]
10:29:50.015 Line::printEndpointInfo [CM505003]: Provider:[VOIPLINE] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [] Transport: [sip:192.168.1.5:5060]
10:29:50.015 LineCfg::getInboundTarget [CM503012]: Inbound office hours' rule for LN:10000 forwards to DN:801
10:29:50.015 CallCtrl::eek:nIncomingCall [CM503001]: Call(5): Incoming call from 6175045858@(Ln.10000@VOIPLINE) to [sip:[email protected]:5060]
10:29:49.953 LineCfg::getInboundTarget [CM503012]: Inbound office hours' rule for LN:10000 forwards to DN:801


On my router, I'm forwarding ports 69, 5060-5063, 9000-9015, 10000-20000 to the 3CX machine... At this test - I'm pushing the incoming call to an AA and I get a "call cannot be completed message". If I push all incoming calls to a phone, the phone will ring - but when you answer the call fails.

I've uninstalled Microsoft Mesh (I thought it suspect). Oh - And I can make OUTBOUND calls all day without issue.
 
Hi

Your issue is relative to ACK not received. This woudl indicate that one or the entities in the SIP conversation is sending a wrong contact IP address. To start off please ensure you are running the latest build.

In the 3CX UI > Advanced please set the SIP domain to the internal IP address of the 3CX server, as I suspect your still reads 'sip.mydomain.com' .

Once done restart the 3CX PhoneSystem services using the 'Restart All' and see if that resolved the issue.
 
Ok.. I updated to the newest version. Redid my extensions and my VOIP/SIP trunk.

13:34:59.203 [MS105000] C:16.1: No RTP packets were received:remoteAddr=147.135.20.250:22830,extAddr=199.232.75.181:9016,localAddr=199.232.75.181:9016
13:34:59.109 [CM503008]: Call(16): Call is terminated
13:34:59.109 [CM503008]: Call(16): Call is terminated
13:34:59.109 [CM503008]: Call(16): Call is terminated
13:34:59.109 [CM503020]: Call(16): ACK is not received
13:34:27.031 [CM503007]: Call(16): Device joined: sip:[email protected]:40600;rinstance=2ac9cf6a3785891b
13:34:27.015 [CM503007]: Call(16): Device joined: sip:[email protected]:5060
13:34:27.015 [CM505001]: Ext.800: Device info: Device Identified: [Man: 3CX Ltd.;Mod: 3CX IVR;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX IVR] Transport: [sip:127.0.0.1:5060]
13:34:27.015 [CM503002]: Call(16): Alerting sip:[email protected]:40600;rinstance=2ac9cf6a3785891b
13:34:26.578 [CM503004]: Call(16): Calling: Ext:Ext.800@[Dev:sip:[email protected]:40600;rinstance=2ac9cf6a3785891b]
13:34:26.578 [CM503010]: Making route(s) to <sip:[email protected]:5060>
13:34:26.562 [CM505003]: Provider:[Broadvoice] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [] Transport: [sip:192.168.1.5:5060]
13:34:26.562 [CM503001]: Call(16): Incoming call from 7819852973@(Ln.10000@Broadvoice) to <sip:[email protected]:5060>
13:34:26.531 [CM503012]: Inbound out-of-office hours rule (unnamed) for 10000 forwards to DN:800


When I force INCOMING calls to a phone (ext 150), the phone will ring, but it's impossible to CONNECT the call. If I send the call to the AA, the caller gets an intercept message... I can make OUTGOING calls without issue.

192.168.1.5 is my PRIVATE IP... I don't see my PUBLIC IP anywhere in this log (should I)?
 
Hi

Can you please confirm that your 3CX STUN settings are enabled and that the 3CX Logs indicate proper STUN resolution. If in doubt restart the 3CX Phonesystem service and send us the log file 3cxphonesystem.log once the lines are all registered. If you have disabled STUN please re-enable.

If you have set the provider to use Specified IP please revert this to 'STUN resolved'.

In the 3CX SIP domain please ensure that you have the 3CX Internal IP and all SIP phones register using the 3CX internal IP

If the issue persists, after changeing / checking the above, can you possibly make a Wireshark capture of such a call and attach in reply to this post? We can then review what signalling is wrong (assuming this is the case) and how best to address.
 
Can you please confirm that your 3CX STUN settings are enabled and that the 3CX Logs indicate proper STUN resolution. If in doubt restart the 3CX Phonesystem service and send us the log file 3cxphonesystem.log once the lines are all registered. If you have disabled STUN please re-enable.

It is enabled, as the DISABLE box is NOT checked. I'll post the log portion in a separate post.

If you have set the provider to use Specified IP please revert this to 'STUN resolved'.

Is already set to STUN resolved.

In the 3CX SIP domain please ensure that you have the 3CX Internal IP and all SIP phones register using the 3CX internal IP

Check, is set to the internal PRIVATE IP.

If the issue persists, after changeing / checking the above, can you possibly make a Wireshark capture of such a call and attach in reply to this post? We can then review what signalling is wrong (assuming this is the case) and how best to address.
 
16:40:37.578|.\VExtMgr.cpp(78)|Log2|DataBase|FaxCfg::updateContact:[CM504008]: Fax Service: registered as sip:[email protected]:5060 with contact sip:[email protected]:5100;user=phone<br>
16:44:34.156|.\Authorization.cpp(368)|Error1||evt::CheckAuth::not_handled:[CM302002]: Authentication failed due to unidentified source of: SipReq: REGISTER 192.168.1.5 tid=-ac45bbbe cseq=REGISTER [email protected]:5060 / 62 from(wire)<br>
16:44:34.156|.\Authorization.cpp(323)|Log2||printDetailedInfo:[CM502001]: Source info: From: "106"<sip:[email protected]>;tag=ba7e30bbc5f4c61bo0; To: "106"<sip:[email protected]><br>
16:44:34.156|.\Authorization.cpp(103)|Critical0|Authorization|AuthMgr::eek:nAuthFailure:[CM102001]: Authentication failed for SipReq: REGISTER 192.168.1.5 tid=-ac45bbbe cseq=REGISTER [email protected]:5060 / 62 from(wire); Reason: Credentials don't match, check that authorization-ID and password match the ones in extension settings<br>
16:45:37.703|.\VExtMgr.cpp(78)|Log2|DataBase|FaxCfg::updateContact:[CM504008]: Fax Service: registered as sip:[email protected]:5060 with contact sip:[email protected]:5100;user=phone<br>
16:45:55.718|.\Extension.cpp(310)|Log2||ExtnCfg::updateContact:[CM504001]: Ext.102: new contact is registered. Contact(s): [sip:[email protected]:5060/102]<br>
16:48:10.218|.\Extension.cpp(310)|Log2||ExtnCfg::updateContact:[CM504001]: Ext.150: new contact is registered. Contact(s): [sip:[email protected]:5060/150]<br>
16:50:00.937|.\StunClient.cpp(355)|Log2|STUN|StunClient::eek:nInitTests:[CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 75.101.138.128:3478 over Transport 192.168.1.5:5060<br>
16:50:37.765|.\VExtMgr.cpp(78)|Log2|DataBase|FaxCfg::updateContact:[CM504008]: Fax Service: registered as sip:[email protected]:5060 with contact sip:[email protected]:5100;user=phone<br>
16:51:03.125|.\SLServer.cpp(759)|Log2|MediaServer|MediaServerReporting::Service:*** Server started ***<br>
16:51:03.125|.\SLServer.cpp(759)|Log2|MediaServer|MediaServerReporting::Service:*** Exit Listen ***<br>
16:51:03.125|.\SLServer.cpp(759)|Log2|MediaServer|MediaServerReporting::Service:*** Server shut down ***<br>
16:51:05.421|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.*0: a contact is unregistered. Contact(s): []<br>
16:51:05.421|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.*1: a contact is unregistered. Contact(s): []<br>
16:51:05.953|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.*0: a contact is unregistered. Contact(s): []<br>
16:51:05.953|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.*1: a contact is unregistered. Contact(s): []<br>
16:51:09.671|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.999: a contact is unregistered. Contact(s): []<br>
16:51:09.687|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.800: a contact is unregistered. Contact(s): []<br>
16:51:10.203|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.999: a contact is unregistered. Contact(s): []<br>
16:51:10.203|.\Extension.cpp(342)|Log2||ExtnCfg::updateContact:[CM504002]: Ext.800: a contact is unregistered. Contact(s): []<br>
16:51:11.390|.\VExtMgr.cpp(93)|Log2|DataBase|FaxCfg::updateContact:[CM504010]: Fax Service: unregistered contact sip:888:5100;user=phone<br>
16:51:11.906|.\VExtMgr.cpp(93)|Log2|DataBase|FaxCfg::updateContact:[CM504010]: Fax Service: unregistered contact sip:888:5100;user=phone<br>
16:51:12.343|.\MSInterface.cpp(734)|Log2||MediaServerConnected:[CM112000] Media Server is connected<br>
16:51:18.718|.\VExtMgr.cpp(78)|Log2|DataBase|FaxCfg::updateContact:[CM504008]: Fax Service: registered as sip:[email protected]:5060 with contact sip:[email protected]:5100;user=phone<br>
16:51:20.125|.\Extension.cpp(310)|Log2||ExtnCfg::updateContact:[CM504001]: Ext.*0: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=c288edc6dc952191/*0]<br>
16:51:20.203|.\Extension.cpp(310)|Log2||ExtnCfg::updateContact:[CM504001]: Ext.*1: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=4ebc2dcc74f071d3/*1]<br>
16:51:25.093|.\Extension.cpp(310)|Log2||ExtnCfg::updateContact:[CM504001]: Ext.999: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=557136d88983dd36/999]<br>
16:51:25.109|.\Extension.cpp(310)|Log2||ExtnCfg::updateContact:[CM504001]: Ext.800: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=b462c9ed33f7ddaa/800]<br>
 
I've installed wireshark... Is there something specific you want me to capture or setup to capture -- or just send you the entire log as I capture it?
 
SIPfun said:
16:44:34.156|.\Authorization.cpp(103)|Critical0|Authorization|AuthMgr::eek:nAuthFailure:[CM102001]: Authentication failed for SipReq: REGISTER 192.168.1.5 tid=-ac45bbbe cseq=REGISTER [email protected]:5060 / 62 from(wire); Reason: Credentials don't match, check that authorization-ID and password match the ones in extension settings<br>

You have a AuthID and password mismatch here - you need to sort that out first.
 
I think that's just a phone extension that I haven't loaded into 3CX that's trying to attach... I do not believe it's related to the VOIP provider... But I'll clear that up right now.

Yeah 106 is just an extension... The phone ATA was trying to connect, and I hadn't added it to 3CX... I hope (and doubt) a rogue ATA would cause my VOIP/SIP to fail incoming calls.

discovery1 said:
SIPfun said:
16:44:34.156|.\Authorization.cpp(103)|Critical0|Authorization|AuthMgr::eek:nAuthFailure:[CM102001]: Authentication failed for SipReq: REGISTER 192.168.1.5 tid=-ac45bbbe cseq=REGISTER [email protected]:5060 / 62 from(wire); Reason: Credentials don't match, check that authorization-ID and password match the ones in extension settings<br>

You have a AuthID and password mismatch here - you need to sort that out first.
 
Hi

Please attach the capture.
 
Here's the wireshark log... Sorry for the delay - I thought I already upped it... Ahhh.. It was too large... I had to to RAR it.
 

Attachments

  • wireshark.rar
    165.3 KB · Views: 91
Hi

TXT format does not allow us to sort by SIP and VOIP call analysis in a proper view. Can you send in PCAP format?
 
PCAP is a format support by WireShark I'm assuming... Yes - I'll look at that.
 
Here.. I think this is what you want.

I did an inbound call during the capture.
 

Attachments

  • SIP-WS_CAP.rar
    97.1 KB · Views: 84
How was that latest wireshark?
 
HI

It appears that the Remote side is not getting any traffic back from 3CX. in fact 3CX sends back Trying and Rigning responses but the Remote side never appears to to get these.

What is there on the Remote end? Put the device directly on public IP without router / NAT and see if the situation changes.
 
Status
Not open for further replies.

Getting Started - Admin

Latest Posts

Forum statistics

Threads
141,612
Messages
748,817
Members
144,725
Latest member
NGPMH
Get 3CX - Absolutely Free!

Link up your team and customers Phone System Live Chat Video Conferencing

Hosted or Self-managed. Up to 10 users free forever. No credit card. Try risk free.

3CX
A 3CX Account with that email already exists. You will be redirected to the Customer Portal to sign in or reset your password if you've forgotten it.