Voicemail on no answer not working anymore with frepbx13?

Hello

First i am sorry if my english is not good at all. I try to do my best and i hope you will understand my question.

I have switched to freepbx 13 and i have a problem with voicemail.

I have put a voicemail on extension 55.

When i configure inbound route to send directly to the voicemail, it works perfectly. So the voice mail itself is ok.

Ben when i configure inbound route to send to an extension ( 55 ) and on this extension, i configure the “optional destinations” to the same voicemail on no answer, it hangup instead of sending the caller to the voice mail.

Here is the logs.

Somone can help me please to understand what is wrong ?

Thank you

    [2015-09-30 21:53:59] VERBOSE[2102][C-00010b0a] netsock2.c: == Using SIP RTP TOS bits 184
[2015-09-30 21:53:59] VERBOSE[2102][C-00010b0a] netsock2.c: == Using SIP RTP CoS mark 5
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] Goto("SIP/ovh2-0000043c", "from-trunk,01xxxxxx,1") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (from-trunk,01xxxxxx,1)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] Set("SIP/ovh2-0000043c", "__FROM_DID=01xxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/ovh2-0000043c", "CHANNEL(language)=fr") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] Gosub("SIP/ovh2-0000043c", "sub-record-check,s,1(in,01xxxxxx,force)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/ovh2-0000043c", "0?initialized") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/ovh2-0000043c", "__REC_STATUS=INITIALIZED") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] Set("SIP/ovh2-0000043c", "NOW=1443642839") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] Set("SIP/ovh2-0000043c", "__DAY=30") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] Set("SIP/ovh2-0000043c", "__MONTH=09") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:6] Set("SIP/ovh2-0000043c", "__YEAR=2015") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:7] Set("SIP/ovh2-0000043c", "__TIMESTR=20150930-215359") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:8] Set("SIP/ovh2-0000043c", "__FROMEXTEN=unknown") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:9] Set("SIP/ovh2-0000043c", "__MON_FMT=wav") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:10] NoOp("SIP/ovh2-0000043c", "Recordings initialized") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:11] ExecIf("SIP/ovh2-0000043c", "0?Set(ARG3=dontcare)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:12] Set("SIP/ovh2-0000043c", "REC_POLICY_MODE_SAVE=") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:13] ExecIf("SIP/ovh2-0000043c", "0?Set(REC_STATUS=NO)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:14] GotoIf("SIP/ovh2-0000043c", "2?checkaction") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,s,17)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:17] GotoIf("SIP/ovh2-0000043c", "1?sub-record-check,in,1") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,in,1)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] NoOp("SIP/ovh2-0000043c", "Inbound Recording Check to 01xxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/ovh2-0000043c", "FROMEXTEN=unknown") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] ExecIf("SIP/ovh2-0000043c", "10?Set(FROMEXTEN=06xxxxxxxx)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] Gosub("SIP/ovh2-0000043c", "recordcheck,1(force,in,01xxxxxx)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] NoOp("SIP/ovh2-0000043c", "Starting recording check against force") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Goto("SIP/ovh2-0000043c", "force") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,recordcheck,5)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] Set("SIP/ovh2-0000043c", "__REC_POLICY_MODE=FORCE") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:6] GotoIf("SIP/ovh2-0000043c", "1?startrec") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,recordcheck,16)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:16] NoOp("SIP/ovh2-0000043c", "Starting recording: in, 01xxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:17] Set("SIP/ovh2-0000043c", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:18] Set("SIP/ovh2-0000043c", "__CALLFILENAME=in-01xxxxxx-06xxxxxxxx-20150930-215359-1443642839.527960") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:19] MixMonitor("SIP/ovh2-0000043c", "2015/09/30/in-01xxxxxx-06xxxxxxxx-20150930-215359-1443642839.527960.wav,ai(LOCAL_MIXMON_ID),") in new stack
[2015-09-30 21:53:59] VERBOSE[1972][C-00010b0a] app_mixmonitor.c: == Begin MixMonitor Recording SIP/ovh2-0000043c
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:20] Set("SIP/ovh2-0000043c", "__MIXMON_ID=0x7f5cf4003a50") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:21] Set("SIP/ovh2-0000043c", "__RECORD_ID=SIP/ovh2-0000043c") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:22] Set("SIP/ovh2-0000043c", "__REC_STATUS=RECORDING") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:23] Set("SIP/ovh2-0000043c", "CDR(recordingfile)=in-01xxxxxx-06xxxxxxxx-20150930-215359-1443642839.527960.wav") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:24] Return("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] Return("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] Gosub("SIP/ovh2-0000043c", "app-blacklist-check,s,1()") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/ovh2-0000043c", "0?blacklisted") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/ovh2-0000043c", "CALLED_BLACKLIST=1") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] Return("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] Set("SIP/ovh2-0000043c", "CDR(did)=01xxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:6] ExecIf("SIP/ovh2-0000043c", "0 ?Set(CALLERID(name)=06xxxxxxxx)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:7] Set("SIP/ovh2-0000043c", "CHANNEL(musicclass)=default") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:8] Set("SIP/ovh2-0000043c", "__MOHCLASS=default") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:9] Set("SIP/ovh2-0000043c", "__REVERSAL_REJECT=FALSE") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:10] GotoIf("SIP/ovh2-0000043c", "1?post-reverse-charge") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (from-trunk,01xxxxxx,12)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:12] NoOp("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:13] Set("SIP/ovh2-0000043c", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:14] Set("SIP/ovh2-0000043c", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:15] Set("SIP/ovh2-0000043c", "CALLERID(name-pres)=allowed_not_screened") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:16] Set("SIP/ovh2-0000043c", "CALLERID(num-pres)=allowed_not_screened") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:17] Goto("SIP/ovh2-0000043c", "from-did-direct,55,1") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (from-did-direct,55,1)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/ovh2-0000043c", "0?ext-local,55,1") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Macro("SIP/ovh2-0000043c", "user-callerid,") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] Set("SIP/ovh2-0000043c", "TOUCH_MONITOR=1443642839.527960") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/ovh2-0000043c", "AMPUSER=06xxxxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] GotoIf("SIP/ovh2-0000043c", "0?report") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] ExecIf("SIP/ovh2-0000043c", "1?Set(REALCALLERIDNUM=06xxxxxxxx)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] Set("SIP/ovh2-0000043c", "AMPUSER=") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:6] GotoIf("SIP/ovh2-0000043c", "0?limit") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:7] Set("SIP/ovh2-0000043c", "AMPUSERCIDNAME=") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:8] GotoIf("SIP/ovh2-0000043c", "1?report") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (macro-user-callerid,s,16)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:16] GotoIf("SIP/ovh2-0000043c", "0?continue") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:17] ExecIf("SIP/ovh2-0000043c", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:18] Set("SIP/ovh2-0000043c", "__TTL=64") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:19] GotoIf("SIP/ovh2-0000043c", "1?continue") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (macro-user-callerid,s,30)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:30] Set("SIP/ovh2-0000043c", "CALLERID(number)=06xxxxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:31] Set("SIP/ovh2-0000043c", "CALLERID(name)=06xxxxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:32] Set("SIP/ovh2-0000043c", "CDR(cnum)=06xxxxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:33] Set("SIP/ovh2-0000043c", "CDR(cnam)=06xxxxxxxx") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:34] Set("SIP/ovh2-0000043c", "CHANNEL(language)=fr") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] Set("SIP/ovh2-0000043c", "DIAL_OPTIONS=TtrI") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] Set("SIP/ovh2-0000043c", "CONNECTEDLINE(num,i)=55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] Gosub("SIP/ovh2-0000043c", "sub-presencestate-display,s,1(55)") in new stack
[2015-09-30 21:53:59] WARNING[1970][C-00010b0a] func_presencestate.c: PRESENCE_STATE unknown
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] Goto("SIP/ovh2-0000043c", "state-,1") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-presencestate-display,state-,1)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] Set("SIP/ovh2-0000043c", "PRESENCESTATE_DISPLAY=") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Return("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:6] Set("SIP/ovh2-0000043c", "CONNECTEDLINE(name)=55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:7] Set("SIP/ovh2-0000043c", "FM_DIALSTATUS=NOT_INUSE") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:8] Set("SIP/ovh2-0000043c", "__EXTTOCALL=55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:9] Set("SIP/ovh2-0000043c", "__PICKUPMARK=55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:10] Macro("SIP/ovh2-0000043c", "blkvm-setifempty,") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/ovh2-0000043c", "1?init") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (macro-blkvm-setifempty,s,4)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] Set("SIP/ovh2-0000043c", "__BLKVM_CHANNEL=SIP/ovh2-0000043c") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] Set("SIP/ovh2-0000043c", "SHARED(BLKVM,SIP/ovh2-0000043c)=TRUE") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:6] Set("SIP/ovh2-0000043c", "GOSUB_RETVAL=TRUE") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:7] MacroExit("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:11] GotoIf("SIP/ovh2-0000043c", "1?skipov") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (from-did-direct,55,14)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:14] Set("SIP/ovh2-0000043c", "RRNODEST=") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:15] Set("SIP/ovh2-0000043c", "__NODEST=55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:16] GosubIf("SIP/ovh2-0000043c", "0?sub-fmsetcid,s,1()") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:17] Set("SIP/ovh2-0000043c", "RecordMethod=Group") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:18] Gosub("SIP/ovh2-0000043c", "sub-record-check,s,1(exten,55,)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/ovh2-0000043c", "10?initialized") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,s,10)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:10] NoOp("SIP/ovh2-0000043c", "Recordings initialized") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:11] ExecIf("SIP/ovh2-0000043c", "1?Set(ARG3=dontcare)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:12] Set("SIP/ovh2-0000043c", "REC_POLICY_MODE_SAVE=FORCE") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:13] ExecIf("SIP/ovh2-0000043c", "0?Set(REC_STATUS=NO)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:14] GotoIf("SIP/ovh2-0000043c", "5?checkaction") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,s,17)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:17] GotoIf("SIP/ovh2-0000043c", "1?sub-record-check,exten,1") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,exten,1)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] NoOp("SIP/ovh2-0000043c", "Exten Recording Check between 06xxxxxxxx and 55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/ovh2-0000043c", "CALLTYPE=external") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] ExecIf("SIP/ovh2-0000043c", "0?Set(CALLTYPE=)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] Set("SIP/ovh2-0000043c", "CALLEE=yes") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:5] ExecIf("SIP/ovh2-0000043c", "0?Set(CALLEE=dontcare)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:6] GotoIf("SIP/ovh2-0000043c", "1?callee") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,exten,11)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:11] Gosub("SIP/ovh2-0000043c", "recordcheck,1(yes,external,55)") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] NoOp("SIP/ovh2-0000043c", "Starting recording check against yes") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Goto("SIP/ovh2-0000043c", "yes") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (sub-record-check,recordcheck,9)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:9] ExecIf("SIP/ovh2-0000043c", "1?Return()") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:12] Return("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:19] Set("SIP/ovh2-0000043c", "RingGroupMethod=ringallv2-prim") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:20] Set("SIP/ovh2-0000043c", "_FMGRP=55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:21] GotoIf("SIP/ovh2-0000043c", "0?doconfirm") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:22] Macro("SIP/ovh2-0000043c", "dial,27,TtrI,55") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/ovh2-0000043c", "0?dial") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/ovh2-0000043c", "CHANNEL(musicclass)=default") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] AGI("SIP/ovh2-0000043c", "dialparties.agi") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: dialparties.agi: Caller ID name is '06xxxxxxxx' number is '06xxxxxxxx'
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: dialparties.agi: Methodology of ring is 'ringallv2-prim'
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- dialparties.agi: Added extension 55 to extension map
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- dialparties.agi: Extension 55 cf is disabled
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- dialparties.agi: Extension 55 do not disturb is disabled
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: dialparties.agi: Extension 55 has ExtensionState: 0
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: dialparties.agi: Extension 55 has ExtensionState: 0
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- dialparties.agi: Checking CW and CFB status for extension 55
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- dialparties.agi: dbset CALLTRACE/55 to 06xxxxxxxx
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- dialparties.agi: Filtered ARG3: 55
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] res_agi.c: -- <SIP/ovh2-0000043c>AGI Script dialparties.agi completed, returning 0
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:7] Dial("SIP/ovh2-0000043c", "SIP/55,27,TtrIM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] netsock2.c: == Using SIP RTP TOS bits 184
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] netsock2.c: == Using SIP RTP CoS mark 5
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] app_stack.c: -- SIP/55-0000043d Internal Gosub(func-apply-sipheaders,s,1) start
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] NoOp("SIP/55-0000043d", "Applying SIP Headers to channel") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:2] Set("SIP/55-0000043d", "SIPHEADERKEYS=") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] While("SIP/55-0000043d", "0") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] app_while.c: -- Jumping to priority 7
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:8] Return("SIP/55-0000043d", "") in new stack
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] app_stack.c: == Spawn extension (from-internal, 55, 1) exited non-zero on 'SIP/55-0000043d'
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] app_stack.c: -- SIP/55-0000043d Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] app_dial.c: -- Called SIP/55
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] app_dial.c: -- Connected line update to SIP/ovh2-0000043c prevented.
[2015-09-30 21:53:59] VERBOSE[1970][C-00010b0a] app_dial.c: -- SIP/55-0000043d is ringing
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] app_macro.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/ovh2-0000043c' in macro 'dial'
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] pbx.c: == Spawn extension (from-did-direct, 55, 22) exited non-zero on 'SIP/ovh2-0000043c'
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] Macro("SIP/ovh2-0000043c", "hangupcall,") in new stack
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/ovh2-0000043c", "1?theend") in new stack
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] pbx.c: -- Goto (macro-hangupcall,s,3)
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:3] ExecIf("SIP/ovh2-0000043c", "0?Set(CDR(recordingfile)=)") in new stack
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] pbx.c: -- Executing [[email protected]:4] Hangup("SIP/ovh2-0000043c", "") in new stack
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/ovh2-0000043c' in macro 'hangupcall'
[2015-09-30 21:54:24] VERBOSE[1970][C-00010b0a] pbx.c: == Spawn extension (from-did-direct, h, 1) exited non-zero on 'SIP/ovh2-0000043c'
[2015-09-30 21:54:24] VERBOSE[1972][C-00010b0a] app_mixmonitor.c: == MixMonitor close filestream (mixed)
[2015-09-30 21:54:24] VERBOSE[1972][C-00010b0a] app_mixmonitor.c: == End MixMonitor Recording SIP/ovh2-0000043c

Another point, when i call from an other internal extension to this extension, the voice mail is working.

On internal calls the voicemail is working, but when i receive external call, on any extension, it hang up instead of sending to the voicemail !!!

Thank you for your help