IVR problem

Status
Not open for further replies.

d.wedel

Joined
Sep 22, 2007
Messages
4
Reaction score
0
Hello,

I am new to 3cx phone system.
I use the free version and used in on school with no problem at all.
Now I installed it at home and when I try to call sometimes it works but mostly I hear: "The person you are to call is unavailible." I use xlite as a SIP phone.
I don't know what is wrong but in de server status window all lines are registered as they should but I get this error:
IVR not found on 127.0.0.1:5483
Can anybody tell me if that is the problem?
And if not still what that error means.

Thnx

Don
 
"The person you are to call is unavailible."
It's not come from 3CX's IVR. It's come from Xlite.

Please provide the full details console log for us to investigate.
 
If the IVR is not available or cannot route to it the call gets dropped (engagement signal).

That is where X-lite (or your VSP) will play the message that the called party is not available.

Check your IVR config and make sure the service is running.
 
I stated it wrong I did not call with xlite I called with my cell phone and some times it works perfectly but mostly it sais that the person I try to call is unavailible.
In the status window it says that the voip line is registerd and the extension is registered. I use the extension in xlite.
 
Here is the details log:
21:48:01.500 ServRegs::onAdd [CM113002] Registered: Ext.100
21:48:01.203 ServRegs::onRemove [CM113003] Unregistered: Ext.100
21:48:01.046 ServRegs::onAdd [CM113002] Registered: Ext.100
21:47:38.562 ListenConnect [CM114000] SL: connected PCDON:0/PHPExtension_0 at [PCDON]/PHPExtension_0
21:41:30.640 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
21:41:30.390 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
21:41:30.390 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
21:41:30.375 ClientRegs::onFailure [CM113010] Next registration will be attempted in 10 minutes
21:41:30.375 ClientRegs::onFailure [CM113006] Registration of sip:[email protected] has failed; reason=Bad Request
21:41:30.250 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
21:41:30.250 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='xs4all'
21:41:30.015 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
21:41:30.015 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='xs4all'
21:41:29.796 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
21:41:29.796 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='xs4all'
21:41:29.796 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:55292 by server 64.69.76.23
21:41:29.484 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:55292 by server 64.69.76.23
21:31:29.890 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
21:31:29.875 ClientRegs::onFailure [CM113010] Next registration will be attempted in 10 minutes
21:31:29.875 ClientRegs::onFailure [CM113006] Registration of sip:[email protected] has failed; reason=Bad Request
21:31:29.640 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
21:31:29.640 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='xs4all'
21:21:29.468 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
21:21:29.453 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
21:21:29.453 ClientRegs::onFailure [CM113010] Next registration will be attempted in 10 minutes
21:21:29.453 ClientRegs::onFailure [CM113006] Registration of sip:[email protected] has failed; reason=Bad Request
21:21:29.250 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
21:21:29.250 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='xs4all'
21:21:29.015 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
21:21:29.015 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='xs4all'
21:21:29.015 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:54989 by server 64.69.76.23
21:21:28.375 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:54989 by server 64.69.76.23
21:01:33.515 MediaServerReporting::Service *** Connected to PCDON:5483/IVRServer at 127.0.0.1:5483 ***
21:01:33.500 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:32.984 IVRConnected [CM111000] IVR Server is connected
21:01:32.984 ListenConnect [CM114000] SL: connected PCDON:5483/IVRServer at [PCDON]/IVRServer
21:01:32.500 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:31.765 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
21:01:31.515 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:30.515 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:29.546 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:29.093 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:28.437 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
21:01:28.437 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='xs4all'
21:01:27.500 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:23.953 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:22.875 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:22.875 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:18.781 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:17.687 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:16.546 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:15.562 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:14.562 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:13.562 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:12.484 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:11.484 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:10.515 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:09.515 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:08.546 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:07.546 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:06.468 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:05.468 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:04.500 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:03.500 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:02.421 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:01.421 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:01:00.453 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:59.453 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:58.375 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:57.375 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:56.406 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:55.406 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:54.328 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:53.328 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:52.359 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:51.359 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:50.359 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:49.343 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:48.375 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:48.359 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:54762 by server 64.69.76.23
21:00:46.359 StunClient::process [CM215001] STUN failed to resolve external IP using server 64.69.76.23
21:00:43.156 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:43.109 StunClient::process [CM115001] Send initial STUN request to 64.69.76.23
21:00:42.968 CallMgr::Stack::thread [CM106001] ** Enter Stack Loop **
21:00:42.046 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:42.046 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:30.968 CallMgr::DumThread::thread [CM100004] ** Enter DUM Thread **
21:00:28.953 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:27.953 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:26.890 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:25.875 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:25.296 ListenConnect [CM114000] SL: connected PCDON:0/VoiceBoxManagerService at [PCDON]/VoiceBoxManagerService
21:00:24.906 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:23.937 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:23.687 DBA [CM109000] ** Database connection Ok **
21:00:23.046 CallMgr::Stack::Initialize [CM106000] ** Adding transports **
21:00:23.046 CallMgr::Initialize [CM100003] ** Initializing SIP stack **
21:00:23.046 CallMgr::Initialize [CM100002] Default Local IP address: 192.168.1.72:5060
21:00:22.828 MediaServerConnected [CM112000] Media Server is connected
21:00:22.828 ListenConnect [CM114000] SL: connected PCDON:0/MediaServer at [PCDON]/MediaServer
21:00:22.640 CallMgr::Initialize [CM100001] Version: 3.1.2434.0
21:00:22.640 CallMgr::Initialize [CM100000] Start 3CX PhoneSystem Call Manager
21:00:22.593 LoadLicenceInfo [CM100008] Licence loading error
 
21:00:57.375 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:56.406 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:55.406 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
Just pertaining to the Localhost address - I would backup 3CX, un-install, reboot, clean install and restore. I always seem to suggest this before the various fixes other more knowledgeable members propose because I find it fixes these issues in the simplest manner, just my way :)
 
Mirzab said:
21:00:57.375 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
21:00:56.406 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:00:55.406 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
Just pertaining to the Localhost address - I would backup 3CX, un-install, reboot, clean install and restore. I always seem to suggest this before the various fixes other more knowledgeable members propose because I find it fixes these issues in the simplest manner, just my way :)

Didn't work:

07:19:08.546 ClientRegs::onSuccess [CM113005] Registration of sip:[email protected] is successful
07:19:08.109 ExtLine::Register [CM110004] Send registration for <sip:[email protected]>
07:19:08.109 ExtLine::Register [CM110001] Use External IP for device line registration DN='10000' device='VOIP'
07:17:49.265 ServRegs::onAdd [CM113002] Registered: Ext.100
07:17:49.031 ServRegs::onRemove [CM113003] Unregistered: Ext.100
07:17:48.812 ServRegs::onAdd [CM113002] Registered: Ext.100
07:17:35.015 ListenConnect [CM114000] SL: connected PCDON:0/PHPExtension_0 at [PCDON]/PHPExtension_0
07:14:24.968 ListenConnect [CM114000] SL: connected PCDON:0/VoiceBoxManagerService at [PCDON]/VoiceBoxManagerService
07:14:23.281 MediaServerReporting::Service *** Connected to PCDON:5483/IVRServer at 127.0.0.1:5483 ***
07:14:23.250 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:23.046 IVRConnected [CM111000] IVR Server is connected
07:14:23.046 ListenConnect [CM114000] SL: connected PCDON:5483/IVRServer at [PCDON]/IVRServer
07:14:22.250 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:21.234 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:20.234 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:19.234 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:18.250 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:17.203 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:16.203 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:15.203 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:14.203 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:13.203 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:12.187 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:11.171 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:10.171 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:09.156 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
07:14:08.156 MediaServerReporting::Service IVR not found on 127.0.0.1:5483
07:14:07.140 MediaServerConnected [CM112000] Media Server is connected
07:14:07.140 ListenConnect [CM114000] SL: connected PCDON:0/MediaServer at [PCDON]/MediaServer
07:14:02.921 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:56181 by server 64.69.76.23
07:14:02.578 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:56181 by server 64.69.76.23
07:14:02.390 StunClient::process [CM115001] Send initial STUN request to 64.69.76.23
07:14:02.265 CallMgr::Stack::thread [CM106001] ** Enter Stack Loop **
07:14:02.046 CallMgr::DumThread::thread [CM100004] ** Enter DUM Thread **
07:14:01.984 DBA [CM109000] ** Database connection Ok **
07:14:01.531 CallMgr::Stack::Initialize [CM106000] ** Adding transports **
07:14:01.484 CallMgr::Initialize [CM100003] ** Initializing SIP stack **
07:14:01.484 CallMgr::Initialize [CM100002] Default Local IP address: 192.168.1.72:5060
07:13:59.812 CallMgr::Initialize [CM100001] Version: 3.1.2434.0
07:13:59.812 CallMgr::Initialize [CM100000] Start 3CX PhoneSystem Call Manager
07:13:59.703 LoadLicenceInfo [CM100008] Licence loading error
 
Described problem is not related to IVR at all

d.wedel said:
Hello,

I am new to 3cx phone system.
I use the free version and used in on school with no problem at all.
Now I installed it at home and when I try to call sometimes it works but mostly I hear: "The person you are to call is unavailible." I use xlite as a SIP phone.
I don't know what is wrong but in de server status window all lines are registered as they should but I get this error:
IVR not found on 127.0.0.1:5483
Can anybody tell me if that is the problem?
And if not still what that error means.

Thnx

Don

Specified log entry is not a problem because later you can see log entries:
21:01:33.515 MediaServerReporting::Service *** Connected to PCDON:5483/IVRServer at 127.0.0.1:5483 ***
21:01:33.500 MediaServerReporting::Service *** Connecting to [127.0.0.1:5483] ***
21:01:32.984 IVRConnected [CM111000] IVR Server is connected

You have another problem and it is related to NAT device:
Initial:
21:00:48.359 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:54762 by server 64.69.76.23
21:00:46.359 StunClient::process [CM215001] STUN failed to resolve external IP using server 64.69.76.23

Then:
21:21:29.015 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:54989 by server 64.69.76.23
21:21:28.375 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:54989 by server 64.69.76.23

Then:
21:41:29.796 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:55292 by server 64.69.76.23
21:41:29.484 StunClient::process [CM115002] STUN resolved external IP=84.87.52.54:55292 by server 64.69.76.23

You can see that NAT changes external port associated to local PBX address (PBXHost:5060). As a result, SIP requests sent by VoIP provider stop to reach PBX until PBX recheck association and inform VoIP provider about changes.

You need to find a way to force your NAT to save association between external port and PBXHost:5060 address for longer time (it is preferred way) or configure PBX to perform STUN check more often (not recommended).

Regards
 
Status
Not open for further replies.