Strange Behavior

General Help
1

I have a Freepbx 2.11 setup with a digium td410 analog fxo board connected to one analog pots line. I also have Google voice connected and working correctly. I have incoming route setup to forward any pstn call to a ring group and another route to forward any incoming Google call to a specific extension. What is happening is that when a call comes in on the Google voice line my hardware seems to send a ring signal to my analog phone, it will ring once then asterisk detects this as if it were a call from the outside and send a ring signal to the ring group. This only last two rings on the Sip extensions but is very annoying. The route works correctly and the call is sent to the correct extension. In the cdr report it shows the incoming call as two separate calls.
How can I prevent this from occurring ? One further note, if the POTS line is in use this does not occur and everything is routed correctly.

I Believe this may be a bug. Here is some log info

[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] pbx.c:     – Executing [s@macro-dial-one:35] Set(“Motif/+1305XXXXXXX-029d”, “__CWIGNORE=”) in new stack
[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] pbx.c:     – Executing [s@macro-dial-one:36] Set(“Motif/+1305XXXXXXX-029d”, “__KEEPCID=TRUE”) in new stack
[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] pbx.c:     – Executing [s@macro-dial-one:37] GotoIf(“Motif/+1305XXXXXXX-029d”, “0?usegoto,1”) in new stack
[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] pbx.c:     – Executing [s@macro-dial-one:38] GotoIf(“Motif/+1305XXXXXXX-029d”, “1?godial”) in new stack
[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] pbx.c:     – Goto (macro-dial-one,s,43)
[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] pbx.c:     – Executing [s@macro-dial-one:43] Dial(“Motif/+1305XXXXXXX-029d”, “SCCP/5000,30,TrWwt”) in new stack
[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] app_dial.c:     – Called SCCP/5000
[2014-08-20 17:25:38] VERBOSE[26105][C-00000010] app_dial.c:     – SCCP/5000-00000010 is ringing
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] sig_analog.c:     – Starting simple switch on ‘DAHDI/1-1’
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:1] NoOp(“DAHDI/1-1”, "Entering from-dahdi with DID == ") in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:2] Ringing(“DAHDI/1-1”, “”) in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:3] Set(“DAHDI/1-1”, “DID=s”) in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:4] NoOp(“DAHDI/1-1”, “DID is now s”) in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:5] GotoIf(“DAHDI/1-1”, “1?dahdiok:checkzap”) in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Goto (from-analog,s,9)
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:9] NoOp(“DAHDI/1-1”, “Is a DAHDi Channel”) in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:10] Set(“DAHDI/1-1”, “CHAN=1-1”) in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:11] Set(“DAHDI/1-1”, “CHAN=1”) in new stack
[2014-08-20 17:25:38] VERBOSE[26199][C-00000011] pbx.c:     – Executing [s@from-analog:12] Macro(“DAHDI/1-1”, “from-dahdi-1,s,1”) in new stack

I have a more detailed log but can not post here due to restrictions

2

dahdi 1/1 is an fxo port with a shared analog phone. This is the line that gets the single ring signal and starts the sequence

3

I Think It is similar with my problem. when the phone ringing it display the following?

– Starting simple switch on ‘DAHDI/1-1’
– Executing [s@from-analog:1] NoOp(“DAHDI/1-1”, "Entering from-dahdi with DID == ") in new stack
– Executing [s@from-analog:2] Ringing(“DAHDI/1-1”, “”) in new stack
– Executing [s@from-analog:3] Set(“DAHDI/1-1”, “DID=s”) in new stack
– Executing [s@from-analog:4] NoOp(“DAHDI/1-1”, “DID is now s”) in new stack
– Executing [s@from-analog:5] GotoIf(“DAHDI/1-1”, “1?dahdiok:checkzap”) in new stack
– Goto (from-analog,s,9)
– Executing [s@from-analog:9] NoOp(“DAHDI/1-1”, “Is a DAHDi Channel”) in new stack
– Executing [s@from-analog:10] Set(“DAHDI/1-1”, “CHAN=1-1”) in new stack
– Executing [s@from-analog:11] Set(“DAHDI/1-1”, “CHAN=1”) in new stack
– Executing [s@from-analog:12] Macro(“DAHDI/1-1”, “from-dahdi-1,s,1”) in new stack
– Executing [s@macro-from-dahdi-1:1] NoOp(“DAHDI/1-1”, “Entering macro-from-dahdi-1 with DID = s and setting to: 0115585455”) in new stack
– Executing [s@macro-from-dahdi-1:2] Set(“DAHDI/1-1”, “__FROM_DID=0115585455”) in new stack
– Executing [s@macro-from-dahdi-1:3] Goto(“DAHDI/1-1”, “from-trunk,0115585455,1”) in new stack
– Goto (from-trunk,0115585455,1)
== Channel ‘DAHDI/1-1’ jumping out of macro ‘from-dahdi-1’
– Executing [0115585455@from-trunk:1] Set(“DAHDI/1-1”, “__FROM_DID=0115585455”) in new stack
– Executing [0115585455@from-trunk:2] Gosub(“DAHDI/1-1”, “app-blacklist-check,s,1()”) in new stack
– Executing [s@app-blacklist-check:1] GotoIf(“DAHDI/1-1”, “0?blacklisted”) in new stack
– Executing [s@app-blacklist-check:2] Set(“DAHDI/1-1”, “CALLED_BLACKLIST=1”) in new stack
– Executing [s@app-blacklist-check:3] Return(“DAHDI/1-1”, “”) in new stack
– Executing [0115585455@from-trunk:3] Set(“DAHDI/1-1”, “CDR(did)=0115585455”) in new stack
– Executing [0115585455@from-trunk:4] ExecIf(“DAHDI/1-1”, “1 ?Set(CALLERID(name)=)”) in new stack
– Executing [0115585455@from-trunk:5] Set(“DAHDI/1-1”, “CHANNEL(musicclass)=default”) in new stack
– Executing [0115585455@from-trunk:6] Set(“DAHDI/1-1”, “__MOHCLASS=default”) in new stack
– Executing [0115585455@from-trunk:7] Macro(“DAHDI/1-1”, “privacy-mgr,3,10”) in new stack
– Executing [s@macro-privacy-mgr:1] Set(“DAHDI/1-1”, “KEEPCID=”) in new stack
[2014-12-29 13:55:13] WARNING[2821][C-00000000]: func_math.c:269 math: ‘’ is not a valid number
[2014-12-29 13:55:13] WARNING[2821][C-00000000]: func_math.c:269 math: ‘’ is not a valid number
– Executing [s@macro-privacy-mgr:2] Set(“DAHDI/1-1”, “TESTCID=”) in new stack
– Executing [s@macro-privacy-mgr:3] ExecIf(“DAHDI/1-1”, “1?Set(CALLERID(num)=)”) in new stack
– Executing [s@macro-privacy-mgr:4] PrivacyManager(“DAHDI/1-1”, “3,10”) in new stack
– <DAHDI/1-1> Playing ‘privacy-unident.ulaw’ (language ‘en’)
– <DAHDI/1-1> Playing ‘privacy-prompt.ulaw’ (language ‘en’)
– <DAHDI/1-1> Playing ‘privacy-incorrect.ulaw’ (language ‘en’)
– <DAHDI/1-1> Playing ‘privacy-prompt.ulaw’ (language ‘en’)
– Executing [h@from-trunk:1] Macro(“DAHDI/1-1”, “hangupcall,”) in new stack
– Executing [s@macro-hangupcall:1] GotoIf(“DAHDI/1-1”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf(“DAHDI/1-1”, “0?Set(CDR(recordingfile)=)”) in new stack
– Executing [s@macro-hangupcall:4] Hangup(“DAHDI/1-1”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘DAHDI/1-1’ in macro ‘hangupcall’
== Spawn extension (from-trunk, h, 1) exited non-zero on ‘DAHDI/1-1’
– Hanging up on ‘DAHDI/1-1’
– Hungup ‘DAHDI/1-1’