Hi all,
This is my first post here, but I’ve been using Asterisk Now almost since the begging.
I’m no Linux expert since AsteriskNOW is my only interaction with Linux, but through careful hardware selection I’ve managed to reduce problems to what I can solve by knowledge and/or searching.
This time though I’ve come to a dead end on how to solve this one problem, and I’m starting to bang my head on the wall.
I’m using AsteriskNOW 1.7.1 32-bit with Asterisk 1.8 and freepbx 2.8.1, and a Digium TDM410P with 4 FXO ports without EC hardware.
I’m using 3 of the 4 FXO ports. Each port is supposed to both receive and make calls. Also a VoIP channel is configured only to make calls.
The problem resides on the fact that I’m able to make calls through all 3 analog channels but can’t receive through any of them. All I can hear is the message “bye” and then it puts the call on hold. As of now for testing purposes all 3 channels are routed to a single extension (201).
I’ve trimmed the log to what I assume is the relevant section, but if more is needed please tell me. Here it is:
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [8214689517@from-internal:1] Macro("SIP/201-0000000e", "user-callerid,SKIPTTL,") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/201-0000000e", "AMPUSER=201") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/201-0000000e", "0?report") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/201-0000000e", "1?Set(REALCALLERIDNUM=201)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/201-0000000e", "AMPUSER=201") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/201-0000000e", "AMPUSERCIDNAME=Ivone") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/201-0000000e", "0?report") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/201-0000000e", "AMPUSERCID=201") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/201-0000000e", "CALLERID(all)="Ivone" <201>") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/201-0000000e", "0?Set(CHANNEL(language)=)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/201-0000000e", "1?continue") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Goto (macro-user-callerid,s,19)
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:19] Set("SIP/201-0000000e", "CALLERID(number)=201") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:20] Set("SIP/201-0000000e", "CALLERID(name)=Ivone") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-user-callerid:21] NoOp("SIP/201-0000000e", "Using CallerID "Ivone" <201>") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [8214689517@from-internal:2] NoOp("SIP/201-0000000e", "Calling Out Route: Outbound9519") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [8214689517@from-internal:3] Set("SIP/201-0000000e", "MOHCLASS=default") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [8214689517@from-internal:4] ExecIf("SIP/201-0000000e", "1?Set(TRUNKCIDOVERRIDE=214689519)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [8214689517@from-internal:5] Set("SIP/201-0000000e", "_NODEST=") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [8214689517@from-internal:6] Macro("SIP/201-0000000e", "record-enable,201,OUT,") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/201-0000000e", "1?check") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Goto (macro-record-enable,s,4)
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-record-enable:4] ExecIf("SIP/201-0000000e", "0?MacroExit()") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-record-enable:5] GotoIf("SIP/201-0000000e", "0?Group:OUT") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Goto (macro-record-enable,s,15)
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-record-enable:15] GotoIf("SIP/201-0000000e", "0?IN") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-record-enable:16] ExecIf("SIP/201-0000000e", "1?MacroExit()") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [8214689517@from-internal:7] Macro("SIP/201-0000000e", "dialout-trunk,3,214689517,") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/201-0000000e", "DIAL_TRUNK=3") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/201-0000000e", "0?sub-pincheck,s,1") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/201-0000000e", "0?disabletrunk,1") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/201-0000000e", "DIAL_NUMBER=214689517") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/201-0000000e", "DIAL_TRUNK_OPTIONS=tr") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/201-0000000e", "OUTBOUND_GROUP=OUT_3") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/201-0000000e", "1?nomax") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Goto (macro-dialout-trunk,s,9)
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/201-0000000e", "0?skipoutcid") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/201-0000000e", "DIAL_TRUNK_OPTIONS=") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/201-0000000e", "outbound-callerid,3") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/201-0000000e", "0?Set(CALLERPRES()=)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/201-0000000e", "0?Set(REALCALLERIDNUM=201)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/201-0000000e", "1?normcid") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/201-0000000e", "USEROUTCID=") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/201-0000000e", "EMERGENCYCID=") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/201-0000000e", "TRUNKOUTCID=214689519") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/201-0000000e", "1?trunkcid") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/201-0000000e", "1?Set(CALLERID(all)=214689519)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/201-0000000e", "0?Set(CALLERID(all)=)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/201-0000000e", "1?Set(CALLERID(all)=214689519)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/201-0000000e", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/201-0000000e", "0?sub-flp-3,s,1") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/201-0000000e", "OUTNUM=214689517") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/201-0000000e", "custom=DAHDI/2") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/201-0000000e", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:16] Macro("SIP/201-0000000e", "dialout-trunk-predial-hook,") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/201-0000000e", "") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/201-0000000e", "0?bypass,1") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/201-0000000e", "0?customtrunk") in new stack
[Feb 3 02:15:31] VERBOSE[3428] pbx.c: -- Executing [s@macro-dialout-trunk:19] Dial("SIP/201-0000000e", "DAHDI/2/214689517,300,") in new stack
[Feb 3 02:15:31] VERBOSE[3428] app_dial.c: -- Called 2/214689517
[Feb 3 02:15:34] WARNING[3428] chan_dahdi.c: Unable to enable echo cancellation on channel 2 (No such device)
[Feb 3 02:15:34] VERBOSE[3428] app_dial.c: -- DAHDI/2-1 answered SIP/201-0000000e
[Feb 3 02:15:34] VERBOSE[3429] sig_analog.c: -- Starting simple switch on 'DAHDI/1-1'
[Feb 3 02:15:35] DEBUG[3429] chan_dahdi.c: CallerID number: 214687564, name: (null), flags=4
[Feb 3 02:15:35] VERBOSE[3429] pbx.c: == Starting DAHDI/1-1 at ,s,1 failed so falling back to exten 's'
[Feb 3 02:15:35] VERBOSE[3429] pbx.c: == Starting DAHDI/1-1 at ,s,1 still failed so falling back to context 'default'
[Feb 3 02:15:35] VERBOSE[3429] pbx.c: -- Executing [s@default:1] Playback("DAHDI/1-1", "vm-goodbye") in new stack
[Feb 3 02:15:35] WARNING[3429] chan_dahdi.c: Unable to enable echo cancellation on channel 1 (No such device)
[Feb 3 02:15:35] VERBOSE[3429] file.c: -- Playing 'vm-goodbye.ulaw' (language 'en')
[Feb 3 02:15:36] VERBOSE[3430] manager.c: == Manager 'admin' logged on from 127.0.0.1
[Feb 3 02:15:36] VERBOSE[3430] manager.c: == Manager 'admin' logged off from 127.0.0.1
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@default:2] Macro("DAHDI/1-1", "hangupcall") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("DAHDI/1-1", "1?skiprg") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Goto (macro-hangupcall,s,4)
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:4] GotoIf("DAHDI/1-1", "1?skipblkvm") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Goto (macro-hangupcall,s,7)
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("DAHDI/1-1", "1?theend") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Goto (macro-hangupcall,s,9)
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:9] Hangup("DAHDI/1-1", "") in new stack
[Feb 3 02:15:36] VERBOSE[3429] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'DAHDI/1-1' in macro 'hangupcall'
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: == Spawn extension (default, s, 2) exited non-zero on 'DAHDI/1-1'
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [h@default:1] Macro("DAHDI/1-1", "hangupcall,") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("DAHDI/1-1", "1?skiprg") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Goto (macro-hangupcall,s,4)
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:4] GotoIf("DAHDI/1-1", "1?skipblkvm") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Goto (macro-hangupcall,s,7)
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("DAHDI/1-1", "1?theend") in new stack
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Goto (macro-hangupcall,s,9)
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: -- Executing [s@macro-hangupcall:9] Hangup("DAHDI/1-1", "") in new stack
[Feb 3 02:15:36] VERBOSE[3429] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'DAHDI/1-1' in macro 'hangupcall'
[Feb 3 02:15:36] VERBOSE[3429] pbx.c: == Spawn extension (default, h, 1) exited non-zero on 'DAHDI/1-1'
[Feb 3 02:15:36] VERBOSE[3429] sig_analog.c: -- Hanging up on 'DAHDI/1-1'
[Feb 3 02:15:36] VERBOSE[3429] chan_dahdi.c: -- Hungup 'DAHDI/1-1'
[Feb 3 02:15:43] VERBOSE[3435] manager.c: == Manager 'admin' logged on from 127.0.0.1
[Feb 3 02:15:44] VERBOSE[3435] manager.c: == Manager 'admin' logged off from 127.0.0.1
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/201-0000000e", "hangupcall,") in new stack
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/201-0000000e", "1?skiprg") in new stack
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Goto (macro-hangupcall,s,4)
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Executing [s@macro-hangupcall:4] GotoIf("SIP/201-0000000e", "1?skipblkvm") in new stack
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Goto (macro-hangupcall,s,7)
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/201-0000000e", "1?theend") in new stack
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Goto (macro-hangupcall,s,9)
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: -- Executing [s@macro-hangupcall:9] Hangup("SIP/201-0000000e", "") in new stack
[Feb 3 02:15:55] VERBOSE[3428] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/201-0000000e' in macro 'hangupcall'
[Feb 3 02:15:55] VERBOSE[3428] sig_analog.c: -- Hanging up on 'DAHDI/2-1'
[Feb 3 02:15:55] VERBOSE[3428] chan_dahdi.c: -- Hungup 'DAHDI/2-1'
[Feb 3 02:15:55] VERBOSE[3428] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on 'SIP/201-0000000e' in macro 'dialout-trunk'
[Feb 3 02:15:55] VERBOSE[3428] pbx.c: == Spawn extension (from-internal, 8214689517, 7) exited non-zero on 'SIP/201-0000000e'
I’d be very grateful for any possible assistance.
Best Regards,
jb