- Joined
- Oct 28, 2010
- Messages
- 15
- Reaction score
- 0
Newbie in need of some help, I have setup 3CX on Win Web Server 2008 and it seems to register ok with my VOIP service (iiNET), and the two phones register and can call each other. When I go to make a call it comes up forbidden, and inbound calls just go to my VOIP provider VM service.
I have switched from a working CISCO SPA9000 system so I know the service should work. I have a dual WAN router so I was careful to make sure SIP traffic is going to the right WAN port and have set a fixed IP and turned off STUN.
I have followed details on this forum from people that have got it working, so I must have misconfigured something or not read enough of the manual yet perhaps?
I have an inbound rule with DDI set to my external number and diverted to my extension. The outbound rule does not have any prefix set and looks for 10 digit numbers
Here are some log entries from restart of services, trunk and handset registration and then attempt at outbound calls. (132200 came back as invalid as the outbound rule had 10 digits set which I have since removed)
EDIT: yes the external IP looks invalid, I changed it for privacy/security
18:48:46.599 [CM503020]: Normal call termination. Reason: Forbidden
18:48:46.599 [CM503016]: Call(3): Attempt to reach <sip:[email protected]> failed. Reason: Forbidden
18:48:46.599 [CM503003]: Call(3): Call to sip:[email protected]:5060 has failed; Cause: 403 Forbidden; from IP:203.666.666.123:5060
18:48:46.521 [CM503025]: Call(3): Calling VoIPline:0287993299@(Ln.10000@iiNet)@[Dev:sip:[email protected]:5060]
18:48:46.458 [CM503004]: Call(3): Route 1: VoIPline:0287993299@(Ln.10000@iiNet)@[Dev:sip:[email protected]:5060]
18:48:46.458 [CM503010]: Making route(s) to <sip:[email protected]>
18:48:46.458 [CM505001]: Ext.800: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA942-6.1.5(a)] PBX contact: [sip:[email protected]:5060]
18:48:46.458 [CM503001]: Call(3): Incoming call from Ext.800 to <sip:[email protected]>
18:48:26.567 [CM503020]: Normal call termination. Reason: Not found
18:48:26.567 [CM503016]: Call(2): Attempt to reach <sip:[email protected]> failed. Reason: Not Found
18:48:26.567 [CM503014]: Call(2): No known route to target: <sip:[email protected]>
18:48:26.552 [CM503010]: Making route(s) to <sip:[email protected]>
18:48:26.552 [CM505001]: Ext.800: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA942-6.1.5(a)] PBX contact: [sip:[email protected]:5060]
18:48:26.552 [CM503001]: Call(2): Incoming call from Ext.800 to <sip:[email protected]>
18:48:00.661 [CM504001]: Ext.800: new contact is registered. Contact(s): [sip:[email protected]:5060/800]
18:47:42.333 [CM504002]: Ext.800: a contact is unregistered. Contact(s): []
18:47:18.614 [CM503020]: Normal call termination. Reason: Not found
18:47:18.614 [CM503016]: Call(1): Attempt to reach <sip:[email protected]> failed. Reason: Not Found
18:47:18.614 [CM503014]: Call(1): No known route to target: <sip:[email protected]>
18:47:18.614 [CM503010]: Making route(s) to <sip:[email protected]>
18:47:18.614 [CM505001]: Ext.800: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA942-6.1.5(a)] PBX contact: [sip:[email protected]:5060]
18:47:18.583 [CM503001]: Call(1): Incoming call from Ext.800 to <sip:[email protected]>
18:46:07.880 [CM504001]: Ext.MakeCall: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=0fd6d1d29ae3edf4/MakeCall]
18:46:07.880 [CM504001]: Ext.IVRForward: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=0a665acec87d2f4c/IVRForward]
18:46:07.880 [CM504001]: Ext.EndCall: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=ae7061be2f35cfb8/EndCall]
18:46:07.833 [CM504001]: Ext.999: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=2ca95c8d7fbc698a/999]
18:46:04.189 [CM504004]: Registration succeeded for: 10000@iiNet
18:46:03.912 [CM504003]: Sent registration request for 10000@iiNet
18:46:03.798 IP(s) added:[192.168.1.2]
18:46:03.796 [CM504001]: Ext.SP9: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=71595777169df00a/SP9]
18:46:03.795 [CM504001]: Ext.SP8: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=360a3cc3df63f05e/SP8]
18:46:03.794 [CM504001]: Ext.SP7: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=24c003f1f7a877d5/SP7]
18:46:03.794 [CM504001]: Ext.SP6: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=fb65277eb34751eb/SP6]
18:46:03.793 [CM504001]: Ext.SP5: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=4e97380ec609439f/SP5]
18:46:03.793 [CM504001]: Ext.SP4: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=137045bb07cb2028/SP4]
18:46:03.792 [CM504001]: Ext.SP3: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=442bb174d2e816e2/SP3]
18:46:03.792 [CM504001]: Ext.SP2: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=07f684b78be4aac1/SP2]
18:46:03.780 [CM504001]: Ext.SP1: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=074d48320a2a72e7/SP1]
18:46:03.752 [CM504001]: Ext.SP0: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=9f921a71b3a65925/SP0]
18:46:03.722 [CM504001]: Ext.*1: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=de5fb90c73f560ec/*1]
18:46:03.682 [CM504001]: Ext.*0: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=9fc005c92599bc08/*0]
18:46:03.643 [CM504001]: Ext.*777: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=c6f62ce9c0101417/*777]
18:46:02.304 [CM504001]: Ext.704: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=47567522a0e7188c/704]
18:46:02.304 [CM504001]: Ext.703: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=1a36a4a3435f6348/703]
18:46:02.304 [CM504001]: Ext.702: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=7e66b5f305011372/702]
18:46:02.288 [CM504001]: Ext.701: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=89c0dc29a443bb15/701]
18:46:02.273 [CM504001]: Ext.700: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=dc6992a9113a08d5/700]
18:45:57.322 [CM504008]: Fax Service: registered as sip:[email protected]:5060 with contact sip:[email protected]:5100;user=phone
18:45:57.260 [EC200002]: Media server is connected: application:VOIPSERVER01:0/MediaServer local:127.0.0.1:5482 remote:127.0.0.1:62425
18:45:57.213 [EC200005]: Parking Orbit server is connected: application:VOIPSERVER01:0/3CXParkOrbit local:127.0.0.1:5482 remote:127.0.0.1:62424
18:45:56.900 [EC200004]: IVR server is connected: application:VOIPSERVER01:0/IVRServer local:127.0.0.1:5482 remote:127.0.0.1:62423
18:45:56.666 [CM504004]: Registration succeeded for: 10000@iiNet
18:45:56.275 [CM504003]: Sent registration request for 10000@iiNet
18:45:55.463 [EC200006]: Conference server is connected: application:VOIPSERVER01:0/3CXConferenceRoom local:127.0.0.1:5482 remote:127.0.0.1:62418
18:45:53.744 [CM506005]: Public IP=203.206.142.102 is used for WAN communications through local interface with IP=192.168.1.2
18:45:53.729 Failed to obtain short path name for [C:\ProgramData\3CX\Bin\Cert]
18:45:53.729 [CM501006]: Default Local IP address: [192.168.1.2]
18:45:53.729 [CM501007]: *** Started Calls Controller thread ***
18:45:53.729 [CM501002]: Version: 9.0.14474.0
18:45:53.729 [CM501001]: Start 3CX PhoneSystem Call Manager
18:45:53.572 [EC200001]: Configuration server is connected: application:VOIPSERVER01:5485/DBProvider local:127.0.0.1:62415 remote:127.0.0.1:5485
18:45:53.572 [CM501009]: License Info: Loaded Succeeded
I have switched from a working CISCO SPA9000 system so I know the service should work. I have a dual WAN router so I was careful to make sure SIP traffic is going to the right WAN port and have set a fixed IP and turned off STUN.
I have followed details on this forum from people that have got it working, so I must have misconfigured something or not read enough of the manual yet perhaps?
I have an inbound rule with DDI set to my external number and diverted to my extension. The outbound rule does not have any prefix set and looks for 10 digit numbers
Here are some log entries from restart of services, trunk and handset registration and then attempt at outbound calls. (132200 came back as invalid as the outbound rule had 10 digits set which I have since removed)
EDIT: yes the external IP looks invalid, I changed it for privacy/security
18:48:46.599 [CM503020]: Normal call termination. Reason: Forbidden
18:48:46.599 [CM503016]: Call(3): Attempt to reach <sip:[email protected]> failed. Reason: Forbidden
18:48:46.599 [CM503003]: Call(3): Call to sip:[email protected]:5060 has failed; Cause: 403 Forbidden; from IP:203.666.666.123:5060
18:48:46.521 [CM503025]: Call(3): Calling VoIPline:0287993299@(Ln.10000@iiNet)@[Dev:sip:[email protected]:5060]
18:48:46.458 [CM503004]: Call(3): Route 1: VoIPline:0287993299@(Ln.10000@iiNet)@[Dev:sip:[email protected]:5060]
18:48:46.458 [CM503010]: Making route(s) to <sip:[email protected]>
18:48:46.458 [CM505001]: Ext.800: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA942-6.1.5(a)] PBX contact: [sip:[email protected]:5060]
18:48:46.458 [CM503001]: Call(3): Incoming call from Ext.800 to <sip:[email protected]>
18:48:26.567 [CM503020]: Normal call termination. Reason: Not found
18:48:26.567 [CM503016]: Call(2): Attempt to reach <sip:[email protected]> failed. Reason: Not Found
18:48:26.567 [CM503014]: Call(2): No known route to target: <sip:[email protected]>
18:48:26.552 [CM503010]: Making route(s) to <sip:[email protected]>
18:48:26.552 [CM505001]: Ext.800: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA942-6.1.5(a)] PBX contact: [sip:[email protected]:5060]
18:48:26.552 [CM503001]: Call(2): Incoming call from Ext.800 to <sip:[email protected]>
18:48:00.661 [CM504001]: Ext.800: new contact is registered. Contact(s): [sip:[email protected]:5060/800]
18:47:42.333 [CM504002]: Ext.800: a contact is unregistered. Contact(s): []
18:47:18.614 [CM503020]: Normal call termination. Reason: Not found
18:47:18.614 [CM503016]: Call(1): Attempt to reach <sip:[email protected]> failed. Reason: Not Found
18:47:18.614 [CM503014]: Call(1): No known route to target: <sip:[email protected]>
18:47:18.614 [CM503010]: Making route(s) to <sip:[email protected]>
18:47:18.614 [CM505001]: Ext.800: Device info: Device Identified: [Man: Linksys;Mod: SPA Series;Rev: General] Capabilities:[reinvite, no-replaces, able-no-sdp, recvonly] UserAgent: [Linksys/SPA942-6.1.5(a)] PBX contact: [sip:[email protected]:5060]
18:47:18.583 [CM503001]: Call(1): Incoming call from Ext.800 to <sip:[email protected]>
18:46:07.880 [CM504001]: Ext.MakeCall: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=0fd6d1d29ae3edf4/MakeCall]
18:46:07.880 [CM504001]: Ext.IVRForward: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=0a665acec87d2f4c/IVRForward]
18:46:07.880 [CM504001]: Ext.EndCall: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=ae7061be2f35cfb8/EndCall]
18:46:07.833 [CM504001]: Ext.999: new contact is registered. Contact(s): [sip:[email protected]:40600;rinstance=2ca95c8d7fbc698a/999]
18:46:04.189 [CM504004]: Registration succeeded for: 10000@iiNet
18:46:03.912 [CM504003]: Sent registration request for 10000@iiNet
18:46:03.798 IP(s) added:[192.168.1.2]
18:46:03.796 [CM504001]: Ext.SP9: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=71595777169df00a/SP9]
18:46:03.795 [CM504001]: Ext.SP8: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=360a3cc3df63f05e/SP8]
18:46:03.794 [CM504001]: Ext.SP7: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=24c003f1f7a877d5/SP7]
18:46:03.794 [CM504001]: Ext.SP6: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=fb65277eb34751eb/SP6]
18:46:03.793 [CM504001]: Ext.SP5: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=4e97380ec609439f/SP5]
18:46:03.793 [CM504001]: Ext.SP4: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=137045bb07cb2028/SP4]
18:46:03.792 [CM504001]: Ext.SP3: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=442bb174d2e816e2/SP3]
18:46:03.792 [CM504001]: Ext.SP2: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=07f684b78be4aac1/SP2]
18:46:03.780 [CM504001]: Ext.SP1: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=074d48320a2a72e7/SP1]
18:46:03.752 [CM504001]: Ext.SP0: new contact is registered. Contact(s): [sip:[email protected]:40000;rinstance=9f921a71b3a65925/SP0]
18:46:03.722 [CM504001]: Ext.*1: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=de5fb90c73f560ec/*1]
18:46:03.682 [CM504001]: Ext.*0: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=9fc005c92599bc08/*0]
18:46:03.643 [CM504001]: Ext.*777: new contact is registered. Contact(s): [sip:*[email protected]:40000;rinstance=c6f62ce9c0101417/*777]
18:46:02.304 [CM504001]: Ext.704: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=47567522a0e7188c/704]
18:46:02.304 [CM504001]: Ext.703: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=1a36a4a3435f6348/703]
18:46:02.304 [CM504001]: Ext.702: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=7e66b5f305011372/702]
18:46:02.288 [CM504001]: Ext.701: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=89c0dc29a443bb15/701]
18:46:02.273 [CM504001]: Ext.700: new contact is registered. Contact(s): [sip:[email protected]:40300;rinstance=dc6992a9113a08d5/700]
18:45:57.322 [CM504008]: Fax Service: registered as sip:[email protected]:5060 with contact sip:[email protected]:5100;user=phone
18:45:57.260 [EC200002]: Media server is connected: application:VOIPSERVER01:0/MediaServer local:127.0.0.1:5482 remote:127.0.0.1:62425
18:45:57.213 [EC200005]: Parking Orbit server is connected: application:VOIPSERVER01:0/3CXParkOrbit local:127.0.0.1:5482 remote:127.0.0.1:62424
18:45:56.900 [EC200004]: IVR server is connected: application:VOIPSERVER01:0/IVRServer local:127.0.0.1:5482 remote:127.0.0.1:62423
18:45:56.666 [CM504004]: Registration succeeded for: 10000@iiNet
18:45:56.275 [CM504003]: Sent registration request for 10000@iiNet
18:45:55.463 [EC200006]: Conference server is connected: application:VOIPSERVER01:0/3CXConferenceRoom local:127.0.0.1:5482 remote:127.0.0.1:62418
18:45:53.744 [CM506005]: Public IP=203.206.142.102 is used for WAN communications through local interface with IP=192.168.1.2
18:45:53.729 Failed to obtain short path name for [C:\ProgramData\3CX\Bin\Cert]
18:45:53.729 [CM501006]: Default Local IP address: [192.168.1.2]
18:45:53.729 [CM501007]: *** Started Calls Controller thread ***
18:45:53.729 [CM501002]: Version: 9.0.14474.0
18:45:53.729 [CM501001]: Start 3CX PhoneSystem Call Manager
18:45:53.572 [EC200001]: Configuration server is connected: application:VOIPSERVER01:5485/DBProvider local:127.0.0.1:62415 remote:127.0.0.1:5485
18:45:53.572 [CM501009]: License Info: Loaded Succeeded