TIPS GVoice only rings once with simonics

thefuzz4

Member
Joined
Apr 30, 2011
Messages
71
Reaction score
4
Hey Everyone,

So I've been using's Bills solution for my gvoice number to vet it out, before I move the Mrs over to it as well. It works great except for one little quirk that I've been trying to work out. I haven't yet pin pointed down the cause of this but sometimes when someone calls in it rings through and if I don't answer it on the first ring then I'll miss it on the PBX. I can still answer the call on my cellphone but its just like something gets dropped somewhere that causes it to mess up. Has anyone else experienced this? Anyone got any thoughts as to some tweaks I can put in.

Here is my info

I'm on Asterisk 11.7
FreePBX 2.11.0.43

One of these days I do intend to completely rebuild my pbx because of some qwerkiness with little things here and there but just not sure when I'll get to it :)

Thank you all for your help with this.
 

billsimon

Well-Known Member
Joined
Jan 2, 2011
Messages
1,535
Reaction score
728
I recommend looking at the Asterisk logs for when a call comes in from GVGW. You should get at least three rings before Google Voice directs the call to voicemail. I can think of the following possibilities:
  • You have some processing going on, e.g. caller ID lookup, fax detection, etc, that takes time and so the call doesn't get to your extension for a while
  • Your other targets in Google Voice (cell phone) are actually answering the call (or "false answering" where it accepts the call and plays back ringing sounds to the caller)
  • There is a delay sending the call to your PBX because GVGW is trying and blocked by your firewall the first few times. It will retry the SIP packets for about 7 seconds until it gives up.
Let us know if the logs reveal anything.
 

thefuzz4

Member
Joined
Apr 30, 2011
Messages
71
Reaction score
4
I apologize for my delay in responding to this. It does take it a bit before it starts to ring on my end but I know that its not going to VM since I can still answer it on my cellphone.

One thing that did show up in the logs today was this:
Code:
chan_sip.c: username mismatch, have <simonics>, digest has <GV1720*******> and then
[2015-07-02 11:40:41] NOTICE[27037][C-0000002c] chan_sip.c: Failed to authenticate device "SAN FRANCIS, CA" <sip:[email protected]>;tag=499651427

but after that it still processes and starts the ring process then about 5 secs later it hangs up.
Code:
[2015-07-02 11:40:48] VERBOSE[15126][C-0000002d] pbx.c:     -- Executing [h@macro-dial:1] Macro("SIP/45.55.163.124-0000005f", "hangupcall") in new stack
[2015-07-02 11:40:48] VERBOSE[15126][C-0000002d] pbx.c:     -- Executing [h@macro-dial:1] Macro("SIP/45.55.163.124-0000005f", "hangupcall") in new stack
[2015-07-02 11:40:48] VERBOSE[15126][C-0000002d] pbx.c:     -- Executing [s@macro-hangupcall:1] GotoIf("SIP/45.55.163.124-0000005f", "1?theend") in new stack
[2015-07-02 11:40:48] VERBOSE[15126][C-0000002d] pbx.c:     -- Executing [s@macro-hangupcall:1] GotoIf("SIP/45.55.163.124-0000005f", "1?theend") in new stack
[2015-07-02 11:40:48] VERBOSE[15126][C-0000002d] pbx.c:     -- Goto (macro-hangupcall,s,3)
[2015-07-02 11:40:48] VERBOSE[15126][C-0000002d] pbx.c:     -- Goto (macro-hangupcall,s,3)

Still digging.
 

thefuzz4

Member
Joined
Apr 30, 2011
Messages
71
Reaction score
4
Hey Bill,

I followed your setup guide and I've turned off the CID Superfect for the moment and the call rings through right away but upon answering it I just get the busy signal. My deskphone actually rings now before my cell does :).

If you would like me to send you my logs let me know and I'll gladly provide them. Here is just what I can see so far
Code:
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] app_dial.c:     -- SIP/706-00000003 answered SIP/GV1720*******-00000000
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:1] Set("SIP/706-00000003", "__MACRO_RESULT=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:1] Set("SIP/706-00000003", "__MACRO_RESULT=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:2] Set("SIP/706-00000003", "CFIGNORE=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:2] Set("SIP/706-00000003", "CFIGNORE=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:3] Set("SIP/706-00000003", "MASTER_CHANNEL(CFIGNORE)=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:3] Set("SIP/706-00000003", "MASTER_CHANNEL(CFIGNORE)=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:4] Set("SIP/706-00000003", "FORWARD_CONTEXT=from-internal") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:4] Set("SIP/706-00000003", "FORWARD_CONTEXT=from-internal") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:5] Set("SIP/706-00000003", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:5] Set("SIP/706-00000003", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:6] Macro("SIP/706-00000003", "blkvm-clr,") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:6] Macro("SIP/706-00000003", "blkvm-clr,") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-blkvm-clr:1] Set("SIP/706-00000003", "SHARED(BLKVM,SIP/GV17202138425-00000000)=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-blkvm-clr:1] Set("SIP/706-00000003", "SHARED(BLKVM,SIP/GV17202138425-00000000)=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-blkvm-clr:2] Set("SIP/706-00000003", "GOSUB_RETVAL=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-blkvm-clr:2] Set("SIP/706-00000003", "GOSUB_RETVAL=") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-blkvm-clr:3] MacroExit("SIP/706-00000003", "") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-blkvm-clr:3] MacroExit("SIP/706-00000003", "") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:7] ExecIf("SIP/706-00000003", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=706)") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:7] ExecIf("SIP/706-00000003", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=706)") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:8] ExecIf("SIP/706-00000003", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Jason Desktop)") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-auto-blkvm:8] ExecIf("SIP/706-00000003", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Jason Desktop)") in new stack
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] res_musiconhold.c:     -- Stopped music on hold on SIP/GV1720*******-00000000
[2015-07-02 12:32:22] VERBOSE[26069][C-00000000] res_musiconhold.c:     -- Stopped music on hold on SIP/GV1720*******-00000000
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [h@macro-dial:1] Macro("SIP/GV1720*******-00000000", "hangupcall") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [h@macro-dial:1] Macro("SIP/GV1720*******-00000000", "hangupcall") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-hangupcall:1] GotoIf("SIP/GV1720*******-00000000", "1?theend") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-hangupcall:1] GotoIf("SIP/GV1720*******-00000000", "1?theend") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Goto (macro-hangupcall,s,3)
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Goto (macro-hangupcall,s,3)
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-hangupcall:3] ExecIf("SIP/GV1720*******-00000000", "0?Set(CDR(recordingfile)=)") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-hangupcall:3] ExecIf("SIP/GV1720*******-00000000", "0?Set(CDR(recordingfile)=)") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-hangupcall:4] Hangup("SIP/GV1720*******-00000000", "") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:     -- Executing [s@macro-hangupcall:4] Hangup("SIP/GV1720*******-00000000", "") in new stack
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] app_macro.c:   == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/GV1720*******-00000000' in macro 'hangupcall'
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] app_macro.c:   == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/GV1720*******-00000000' in macro 'hangupcall'
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:   == Spawn extension (macro-dial, h, 1) exited non-zero on 'SIP/GV1720*******-00000000'
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:   == Spawn extension (macro-dial, h, 1) exited non-zero on 'SIP/GV1720*******-00000000'
[2015-07-02 12:32:23] ERROR[26069][C-00000000] cdr_odbc.c: Unable to retrieve database handle.  CDR failed.
[2015-07-02 12:32:23] ERROR[26069][C-00000000] cdr_odbc.c: Unable to retrieve database handle.  CDR failed.
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] app_macro.c:   == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/GV1720*******-00000000' in macro 'dial'
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] app_macro.c:   == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/GV1720*******-00000000' in macro 'dial'
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:   == Spawn extension (ext-group, 777, 11) exited non-zero on 'SIP/GV1720*******-00000000'
[2015-07-02 12:32:23] VERBOSE[26069][C-00000000] pbx.c:   == Spawn extension (ext-group, 777, 11) exited non-zero on 'SIP/GV1720*******-00000000'
 

thefuzz4

Member
Joined
Apr 30, 2011
Messages
71
Reaction score
4
Ok I think that I have it figured out. I disabled the hold music while its ringing and I also told it to simulate ring as well. It now lets me answer the phone. Thank you for your help very much.
 

Members online

No members online now.

Forum statistics

Threads
25,782
Messages
167,514
Members
19,203
Latest member
frapu
Get 3CX - Absolutely Free!

Link up your team and customers Phone System Live Chat Video Conferencing

Hosted or Self-managed. Up to 10 users free forever. No credit card. Try risk free.

3CX
A 3CX Account with that email already exists. You will be redirected to the Customer Portal to sign in or reset your password if you've forgotten it.
Top