I am a new user with an asterisk PBX in my home running FreePBX 12 inside Centos 6.6.
Using this site http://wiki.freepbx.org/display/FOP/Installing+FreePBX+12+on+CentOS+6.5
I like a challenge but I may be a little out of my league here.
In making an incoming test with my cell phone, all appears fine with prompts to accept message and listen to it as well but the VM never appears in the Inbox.
Voicemail.conf
`[general]
externnotify=/var/lib/asterisk/agi-bin/vmnotify-newvm.php
#include vm_general.inc
#include vm_email.inc
attach=yes
emailsubject=Message from Camelot
envelope=yes
forcegreetings=no
forcename=yes
moveheard=no
nextaftercmd=no
operator=yes
pbxskip=no
review=no
saycid=no
sayduration=yes
searchcontexts=no
sendvoicemail=yes
tempgreetwarn=yes
usedirectory=yes
[default]
; Formats for writing Voicemail. Note that when using IMAP storage for
; voicemail, only the first format specified will be used.
;format=g723sf|wav49|wav
format = wav49|gsm|wav
serveremail = my email@gmail.com
attach = yes
fromstring=The Asterisk PBX
sendvoicemail = yes ; Allow the user to compose and send a voicemail while inside
emailonly = no
emailsubject = You have a New Voicemail from ${VM_CALLERID}
emailbody = Dear ${VM_NAME} ,\n \t\t\t You have received a new voicemail from ${VM_CALLERID} \non ${VM_DATE}. \n Find attached.\n\n----\nAsterisk PBX
maxgreet = 1
operator = no
maxmsg = 25
maxmessage = 300
minmessage = 0
saycid = no
sayduration = no
envelope = no
review = no
101 => 1255,101,my wife email@gmail.com,attach=yes|saycid=yes|envelope=yes|delete=yes
100 => 9897,100,my email@gmail.com,review=yes|maxmessage=60|attach=yes|saycid=yes|envelope=yes|delete=yes
"/etc/asterisk/voicemail.conf" 47L, 1260C
and exerpt from logs [sanitized of course]
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [cidlookup_1@cidlookup:11] Return(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:4] Gosub(“SIP/to-provider-0000090d”, “app-blacklist-check,s,1()”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“SIP/to-provider-0000090d”, “0?blacklisted”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@app-blacklist-check:2] Set(“SIP/to-provider-0000090d”, “CALLED_BLACKLIST=1”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@app-blacklist-check:3] Return(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:5] ExecIf(“SIP/to-provider-0000090d”, “0?Set(__FROM_DID=s)”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:6] Set(“SIP/to-provider-0000090d”, “CDR(did)=+1806DID”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:7] ExecIf(“SIP/to-provider-0000090d”, “1 ?Set(CALLERID(name)=+1806incomoingCID)”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:8] Set(“SIP/to-provider-0000090d”, “CHANNEL(musicclass)=default”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:9] Set(“SIP/to-provider-0000090d”, “__MOHCLASS=default”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:10] Ringing(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:11] Set(“SIP/to-provider-0000090d”, “__RINGINGSENT=TRUE”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:12] Set(“SIP/to-provider-0000090d”, “__REVERSAL_REJECT=TRUE”) in new stack
[2016-05-04 21:26:56] WARNING[58619][C-00000990] func_channel.c: Unknown or unavailable item requested: ‘reversecharge’
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:13] GotoIf(“SIP/to-provider-0000090d”, “0?macro-hangupcall”) in new stack
[2016-05-04 21:26:56] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:14] Wait(“SIP/to-provider-0000090d”, “3”) in new stack
[2016-05-04 21:26:57] VERBOSE[58620][C-00000991] pbx.c: – Executing [s@from-sip-external:9] Playback(“SIP/96.18.192.92-0000090e”, “ss-noservice”) in new stack
[2016-05-04 21:26:57] VERBOSE[58620][C-00000991] file.c: – <SIP/96.18.192.92-0000090e> Playing ‘ss-noservice.ulaw’ (language ‘en’)
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:15] Set(“SIP/to-provider-0000090d”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:16] Set(“SIP/to-provider-0000090d”, “CALLERPRES()=allowed_not_screened”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ext-did:17] Goto(“SIP/to-provider-0000090d”, “ivr-1,s,1”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Goto (ivr-1,s,1)
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:1] Set(“SIP/to-provider-0000090d”, “TIMEOUT_LOOPCOUNT=0”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:2] Set(“SIP/to-provider-0000090d”, “INVALID_LOOPCOUNT=0”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:3] Set(“SIP/to-provider-0000090d”, “_IVR_CONTEXT_ivr-1=”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:4] Set(“SIP/to-provider-0000090d”, “_IVR_CONTEXT=ivr-1”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:5] Set(“SIP/to-provider-0000090d”, “__IVR_RETVM=”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:6] GotoIf(“SIP/to-provider-0000090d”, “0?skip”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:7] Answer(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:26:59] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:8] Wait(“SIP/to-provider-0000090d”, “1”) in new stack
[2016-05-04 21:27:00] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:9] Set(“SIP/to-provider-0000090d”, “IVR_MSG=custom/ivr-3a”) in new stack
[2016-05-04 21:27:00] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:10] Set(“SIP/to-provider-0000090d”, “TIMEOUT(digit)=3”) in new stack
[2016-05-04 21:27:00] VERBOSE[58619][C-00000990] func_timeout.c: – Digit timeout set to 3.000
[2016-05-04 21:27:00] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@ivr-1:11] ExecIf(“SIP/to-provider-0000090d”, “1?Background(custom/ivr-3a)”) in new stack
[2016-05-04 21:27:00] VERBOSE[58619][C-00000990] file.c: – <SIP/to-provider-0000090d> Playing ‘custom/ivr-3a.slin’ (language ‘en’)
[2016-05-04 21:27:02] VERBOSE[58620][C-00000991] pbx.c: – Executing [s@from-sip-external:10] PlayTones(“SIP/96.18.192.92-0000090e”, “congestion”) in new stack
[2016-05-04 21:27:02] VERBOSE[58620][C-00000991] pbx.c: – Executing [s@from-sip-external:11] Congestion(“SIP/96.18.192.92-0000090e”, “5”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [3@ivr-1:1] Goto(“SIP/to-provider-0000090d”, “ext-local,vmu100,1”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (ext-local,vmu100,1)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmu100@ext-local:1] Macro(“SIP/to-provider-0000090d”, “vm,100,NOANSWER,”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-vm:1] Macro(“SIP/to-provider-0000090d”, “user
callerid,SKIPTTL”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/to-provider-0000090d”, “TOUCH_MONITOR=1462415214.2317”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:2] Set(“SIP/to-provider-0000090d”, “AMPUSER=+1806incomoingCID”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/to-provider-0000090d”, “0?report”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/to-provider-0000090d”, “1?Set(REALCALLERIDNUM=+1806incomoingCID)”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/to-provider-0000090d”, “AMPUSER=”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/to-provider-0000090d”, “0?limit”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/to-provider-0000090d”, “AMPUSERCIDNAME=”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“SIP/to-provider-0000090d”, “1?report”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-user-callerid,s,16)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“SIP/to-provider-0000090d”, “1?continue”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:30] Set(“SIP/to-provider-0000090d”, “CALLERID(number)=+1806incomoingCID”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:31] Set(“SIP/to-provider-0000090d”, “CALLERID(name)=+1806incomoingCID”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:32] Set(“SIP/to-provider-0000090d”, “CDR(cnum)=+1806incomoingCID”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:33] Set(“SIP/to-provider-0000090d”, “CDR(cnam)=+1806incomoingCID”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-user-callerid:34] Set(“SIP/to-provider-0000090d”, “CHANNEL(language)=en”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-vm:2] Set(“SIP/to-provider-0000090d”, “VMGAIN=g(12)”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-vm:3] Macro(“SIP/to-provider-0000090d”, “blkvm-check,”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-blkvm-check:1] Set(“SIP/to-provider-0000090d”, “GOSUB_RETVAL=”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-blkvm-check:2] ExecIf(“SIP/to-provider-0000090d”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-blkvm-check:3] MacroExit(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-vm:4] GotoIf(“SIP/to-provider-0000090d”, “1?vmx,1”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-vm,vmx,1)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:1] Set(“SIP/to-provider-0000090d”, “MEXTEN=100”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:2] Set(“SIP/to-provider-0000090d”, “MMODE=NOANSWER”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:3] Set(“SIP/to-provider-0000090d”, “RETVM=”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:4] Set(“SIP/to-provider-0000090d”, “MODE=unavail”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:5] Macro(“SIP/to-provider-0000090d”, “get-vmcontext,100”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“SIP/to-provider-0000090d”, “VMCONTEXT=default”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“SIP/to-provider-0000090d”, “0?200:300”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-get-vmcontext,s,300)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-get-vmcontext:300] NoOp(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:6] Set(“SIP/to-provider-0000090d”, “MODE=unavail”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:7] NoOp(“SIP/to-provider-0000090d”, “MODE IS: unavail”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:8] GotoIf(“SIP/to-provider-0000090d”, “1?chknomsg”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-vm,vmx,10)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:10] GotoIf(“SIP/to-provider-0000090d”, “0?s-NOANSWER,1”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:11] GotoIf(“SIP/to-provider-0000090d”, “1?notdirect”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-vm,vmx,13)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:13] NoOp(“SIP/to-provider-0000090d”, "Checking if ext 100 is enabled: ") in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [vmx@macro-vm:14] GotoIf(“SIP/to-provider-0000090d”, “1?s-NOANSWER,1”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-vm,s-NOANSWER,1)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s-NOANSWER@macro-vm:1] Macro(“SIP/to-provider-0000090d”, “get-vmcontext,100”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“SIP/to-provider-0000090d”, “VMCONTEXT=default”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“SIP/to-provider-0000090d”, “0?200:300”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-get-vmcontext,s,300)
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-get-vmcontext:300] NoOp(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] pbx.c: – Executing [s-NOANSWER@macro-vm:2] VoiceMail(“SIP/to-provider-0000090d”, “100@default,ug(12)”) in new stack
[2016-05-04 21:27:03] VERBOSE[58619][C-00000990] file.c: – <SIP/to-provider-0000090d> Playing ‘/var/spool/asterisk/voicemail/default/100/unavail.slin’ (language ‘en’)
[2016-05-04 21:27:07] VERBOSE[58620][C-00000991] pbx.c: == Spawn extension (from-sip-external, s, 11) exited non-zero on ‘SIP/96.18.192.92-0000090e’
[2016-05-04 21:27:07] VERBOSE[58620][C-00000991] pbx.c: – Executing [h@from-sip-external:1] Hangup(“SIP/96.18.192.92-0000090e”, “”) in new stack
[2016-05-04 21:27:07] VERBOSE[58620][C-00000991] pbx.c: == Spawn extension (from-sip-external, h, 1) exited non-zero on ‘SIP/96.18.192.92-0000090e’
[2016-05-04 21:27:07] VERBOSE[58619][C-00000990] file.c: – <SIP/to-provider-0000090d> Playing ‘vm-intro.alaw’ (language ‘en’)
[2016-05-04 21:27:13] VERBOSE[58619][C-00000990] file.c: – <SIP/to-provider-0000090d> Playing ‘beep.alaw’ (language ‘en’)
[2016-05-04 21:27:13] VERBOSE[58619][C-00000990] app_voicemail.c: – Recording the message
[2016-05-04 21:27:13] VERBOSE[58619][C-00000990] app.c: – x=0, open writing: /var/spool/asterisk/voicemail/default/100/tmp/LEwyDC format: wav, 0x7f1d2c003c18
[2016-05-04 21:27:18] VERBOSE[58619][C-00000990] app.c: – User hung up
[2016-05-04 21:27:18] VERBOSE[58619][C-00000990] config.c: == Parsing ‘/var/spool/asterisk/voicemail/default/100/INBOX/msg0000.txt’: Found
[2016-05-04 21:27:18] VERBOSE[58619][C-00000990] config.c: == Parsing ‘/var/spool/asterisk/voicemail/default/100/INBOX/msg0000.txt’: Found
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] app_macro.c: == Spawn extension (macro-vm, s-NOANSWER, 2) exited non-zero on ‘SIP/to-provider-0000090d’ in macro ‘vm’
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] pbx.c: == Spawn extension (ext-local, vmu100, 1) exited non-zero on ‘SIP/to-provider-0000090d’
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] pbx.c: – Executing [h@ext-local:1] Macro(“SIP/to-provider-0000090d”, “hangupcall,”) in new stack
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-hangupcall:1] ExecIf(“SIP/to-provider-0000090d”, “0?Set(CDR(recordingfile)=.wav)”) in new stack
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-hangupcall:2] GotoIf(“SIP/to-provider-0000090d”, “1?theend”) in new stack
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] pbx.c: – Goto (macro-hangupcall,s,4)
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/to-provider-0000090d”, “”) in new stack
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/to-provider-0000090d’ in macro ‘hangupcall’
[2016-05-04 21:27:19] VERBOSE[58619][C-00000990] pbx.c: == Spawn extension (ext-local, h, 1) exited non-zero on ‘SIP/to-provider-0000090d’
[2016-05-04 21:27:27] WARNING[2119] chan_sip.c: Retransmission timeout reached on transmission d728f00bd0aa21792d4f686084760fa7
`