Cannot dial extensions

Asterisk Asterisk Support
#1

I’ve recently moved a working PBX and 4 Cisco SPA504G phones from a 192.168.100.10 to 192.168.47.10 network. I have been partially successful. I can now call out.

The main error I’m getting now is that I can only reach extension 103 from the other extensions (101, 102, and 104). And 103 also cannot dial the other extensions.

Another issue I’m having is how to turn off, or fix, the automatic call answering. Instead of the phones ringing, a message service asks for an input of ‘1’ or ‘2’, then replies that they are busy.

#2

Did you accidentally press submit before you finished composing the question?

#3

No, sorry. I am fairly new to pbx and phone programming. What could I have missed, or could have done, that these phones can no longer call each other?

On the second topic, “how to turn off, or fix, the automatic call answering” should have ended in a question mark.

#4

Lots of things. Without logging and detailed configurations one would be wasting ones time trying to guess.

#5

How do I get a log?

After the person brought us the pbx and phones, he remoted into my computer and watched a call using Putty. He asked my to call and we watched as Putty displayed everything. I could post that if I knew how to go about it. Do you know the command?

#6

wiki.asterisk.org/wiki/display/ … nformation

#7

Thanks, I didn’t know about those log files. Here is a call from ext. 101 to ext. 102. It returns a busy signal.

[Apr 2 09:04:42] VERBOSE[3376] netsock.c: == Using SIP RTP TOS bits 184
[Apr 2 09:04:42] VERBOSE[3376] netsock.c: == Using SIP RTP CoS mark 5
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [102@from-internal:1] Macro(“SIP/101-00000046”, “exten-vm,novm,102”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:1] Macro(“SIP/101-00000046”, “user-callerid,”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/101-00000046”, “AMPUSER=101”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/101-00000046”, “0?report”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/101-00000046”, “1?Set(REALCALLERIDNUM=101)”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/101-00000046”, “AMPUSER=101”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/101-00000046”, “AMPUSERCIDNAME=101”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/101-00000046”, “0?report”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/101-00000046”, “AMPUSERCID=101”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:8] Set(“SIP/101-00000046”, “CALLERID(all)=“101” <101>”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:9] ExecIf(“SIP/101-00000046”, “0?Set(CHANNEL(language)=)”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:10] GotoIf(“SIP/101-00000046”, “0?continue”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:11] Set(“SIP/101-00000046”, “__TTL=64”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:12] GotoIf(“SIP/101-00000046”, “1?continue”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-user-callerid,s,19)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-user-callerid:19] NoOp(“SIP/101-00000046”, “Using CallerID “101” <101>”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:2] Set(“SIP/101-00000046”, “RingGroupMethod=none”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:3] Set(“SIP/101-00000046”, “VMBOX=novm”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:4] Set(“SIP/101-00000046”, “EXTTOCALL=102”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:5] Set(“SIP/101-00000046”, “CFUEXT=”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:6] Set(“SIP/101-00000046”, “CFBEXT=”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:7] Set(“SIP/101-00000046”, “RT=”"") in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:8] Macro(“SIP/101-00000046”, “record-enable,102,IN”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:1] GotoIf(“SIP/101-00000046”, “1?check”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-record-enable,s,4)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:4] ExecIf(“SIP/101-00000046”, “0?MacroExit()”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:5] GotoIf(“SIP/101-00000046”, “0?Group:OUT”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-record-enable,s,15)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:15] GotoIf(“SIP/101-00000046”, “1?IN”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-record-enable,s,20)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:20] ExecIf(“SIP/101-00000046”, “0?MacroExit()”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:21] NoOp(“SIP/101-00000046”, “Recording enable for 102”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:22] Set(“SIP/101-00000046”, “CALLFILENAME=20130402-090442-1364911482.70”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:23] MixMonitor(“SIP/101-00000046”, “/var/spool/asterisk/monitor/20130402-090442-1364911482.70.wav,/root/recCleanUp”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:24] Set(“SIP/101-00000046”, “CDR(userfield)=audio:20130402-090442-1364911482.70.wav”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-record-enable:25] MacroExit(“SIP/101-00000046”, “”) in new stack
[Apr 2 09:04:42] VERBOSE[20041] app_mixmonitor.c: == Begin MixMonitor Recording SIP/101-00000046
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:9] Macro(“SIP/101-00000046”, “dial,tr,102”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-dial:1] GotoIf(“SIP/101-00000046”, “1?dial”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-dial,s,3)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-dial:3] AGI(“SIP/101-00000046”, “dialparties.agi”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: dialparties.agi: Caller ID name is ‘101’ number is ‘101’
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: dialparties.agi: Methodology of ring is ‘none’
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – dialparties.agi: Added extension 102 to extension map
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – dialparties.agi: Extension 102 cf is disabled
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – dialparties.agi: Extension 102 do not disturb is disabled
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: dialparties.agi: Extension 102 has ExtensionState: 0
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – dialparties.agi: Checking CW and CFB status for extension 102
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – dialparties.agi: dbset CALLTRACE/102 to 101
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – dialparties.agi: Filtered ARG3: 102
[Apr 2 09:04:42] VERBOSE[20040] res_agi.c: – <SIP/101-00000046>AGI Script dialparties.agi completed, returning 0
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-dial:7] Dial(“SIP/101-00000046”, “SIP/102,tr”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] netsock.c: == Using SIP RTP TOS bits 184
[Apr 2 09:04:42] VERBOSE[20040] netsock.c: == Using SIP RTP CoS mark 5
[Apr 2 09:04:42] VERBOSE[20040] app_dial.c: – Called 102
[Apr 2 09:04:42] VERBOSE[3376] chan_sip.c: – Got SIP response 486 “Busy Here” back from 192.168.47.199
[Apr 2 09:04:42] VERBOSE[20040] app_dial.c: – SIP/102-00000047 is busy
[Apr 2 09:04:42] VERBOSE[20040] app_dial.c: == Everyone is busy/congested at this time (1:1/0/0)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-dial:8] Set(“SIP/101-00000046”, “DIALSTATUS=BUSY”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-dial:9] GosubIf(“SIP/101-00000046”, “0?BUSY,1”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:10] GotoIf(“SIP/101-00000046”, “0?exit,return”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:11] Set(“SIP/101-00000046”, “SV_DIALSTATUS=BUSY”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:12] GosubIf(“SIP/101-00000046”, “0?docfu,1”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:13] GosubIf(“SIP/101-00000046”, “0?docfb,1”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:14] Set(“SIP/101-00000046”, “DIALSTATUS=BUSY”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:15] NoOp(“SIP/101-00000046”, “Voicemail is ‘novm’”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-exten-vm:16] GotoIf(“SIP/101-00000046”, “1?s-BUSY,1”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-exten-vm,s-BUSY,1)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s-BUSY@macro-exten-vm:1] NoOp(“SIP/101-00000046”, “Extension is reporting BUSY and not passing to Voicemail”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s-BUSY@macro-exten-vm:2] GotoIf(“SIP/101-00000046”, “0?exit,1”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s-BUSY@macro-exten-vm:3] PlayTones(“SIP/101-00000046”, “busy”) in new stack
[Apr 2 09:04:42] WARNING[20040] translate.c: no samples for g729tolin
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s-BUSY@macro-exten-vm:4] Busy(“SIP/101-00000046”, “20”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] app_macro.c: == Spawn extension (macro-exten-vm, s-BUSY, 4) exited non-zero on ‘SIP/101-00000046’ in macro ‘exten-vm’
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: == Spawn extension (from-internal, 102, 1) exited non-zero on ‘SIP/101-00000046’
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [h@from-internal:1] Macro(“SIP/101-00000046”, “hangupcall”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/101-00000046”, “1?noautomon”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-hangupcall,s,3)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-hangupcall:3] NoOp(“SIP/101-00000046”, “TOUCH_MONITOR_OUTPUT=”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-hangupcall:4] GotoIf(“SIP/101-00000046”, “1?skiprg”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-hangupcall,s,7)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-hangupcall:7] GotoIf(“SIP/101-00000046”, “1?skipblkvm”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-hangupcall,s,10)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-hangupcall:10] GotoIf(“SIP/101-00000046”, “1?theend”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Goto (macro-hangupcall,s,12)
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: – Executing [s@macro-hangupcall:12] Hangup(“SIP/101-00000046”, “”) in new stack
[Apr 2 09:04:42] VERBOSE[20040] app_macro.c: == Spawn extension (macro-hangupcall, s, 12) exited non-zero on ‘SIP/101-00000046’ in macro ‘hangupcall’
[Apr 2 09:04:42] VERBOSE[20040] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/101-00000046’
[Apr 2 09:04:42] VERBOSE[20041] app_mixmonitor.c: == Executing [/root/recCleanUp]
[Apr 2 09:04:42] VERBOSE[20041] app_mixmonitor.c: == End MixMonitor Recording SIP/101-00000046

#8

You appear to be using some form of GUI. If so, you need to direct the question to the people who deal with that GUI. If not, I thinink you are going to have to provide the dialplan and AGI scripts, as they seem to be quite complex.

#9

I am using Elastix. Do you suggest I go to an Elastix specific forum?

#10

[quote][Apr 2 09:04:42] VERBOSE[20040] app_dial.c: – Called 102
[Apr 2 09:04:42] VERBOSE[3376] chan_sip.c: – Got SIP response 486 “Busy Here” back from 192.168.47.199
[Apr 2 09:04:42] VERBOSE[20040] app_dial.c: – SIP/102-00000047 is busy[/quote]

If your phone 102 have the IP 192.168.47.199 check that it doesnt have the Do Not Disturb enabled, the Phone is returning the code 486 Busy Here and then you hear the busy tone.

#11

That was it! Thanks very much.

Do you know this one? How to turn off, or fix, the automatic call answering. Instead of the phones ringing, a message service asks for an input of ‘1’ or ‘2’, then replies that they are busy.

#12

You need to check your inbound route and change the destination instead of IVR you need to set the phones or ring group. But that is GUI specific.