Voicemail stopped working!

namotco · March 25, 2009, 3:16pm

Last night the voicemail stopped working. I get a fast busy signal when I should get my voicemail. When I try to check VM I enter the mailbox number, then it hangs up.

Calling to VM:
– Executing [*700@from-internal:1] Macro(“SIP/1100-b7705248”, “vm|700|DIRECTDIAL|”) in new stack – Executing [s@macro-vm:1] Macro(“SIP/1100-b7705248”, “user-callerid|SKIPTTL”) in new stack – Executing [s@macro-user-callerid:1] Set(“SIP/1100-b7705248”, “AMPUSER=1100”) in new stack – Executing [s@macro-user-callerid:2] GotoIf(“SIP/1100-b7705248”, “0?report”) in new stack – Executing [s@macro-user-callerid:3] ExecIf(“SIP/1100-b7705248”, “1|Set|REALCALLERIDNUM=1100”) in new stack – Executing [s@macro-user-callerid:4] Set(“SIP/1100-b7705248”, “AMPUSER=1100”) in new stack – Executing [s@macro-user-callerid:5] Set(“SIP/1100-b7705248”, “AMPUSERCIDNAME=Computer Room”) in new stack – Executing [s@macro-user-callerid:6] GotoIf(“SIP/1100-b7705248”, “0?report”) in new stack – Executing [s@macro-user-callerid:7] Set(“SIP/1100-b7705248”, “AMPUSERCID=1100”) in new stack – Executing [s@macro-user-callerid:8] Set(“SIP/1100-b7705248”, “CALLERID(all)=“Computer Room” <1100>”) in new stack – Executing [s@macro-user-callerid:9] Set(“SIP/1100-b7705248”, “REALCALLERIDNUM=1100”) in new stack – Executing [s@macro-user-callerid:10] ExecIf(“SIP/1100-b7705248”, “0|Set|CHANNEL(language)=”) in new stack – Executing [s@macro-user-callerid:11] GotoIf(“SIP/1100-b7705248”, “1?continue”) in new stack – Goto (macro-user-callerid,s,20) – Executing [s@macro-user-callerid:20] NoOp(“SIP/1100-b7705248”, “Using CallerID “Computer Room” <1100>”) in new stack – Executing [s@macro-vm:2] Set(“SIP/1100-b7705248”, “VMGAIN=g(6)”) in new stack – Executing [s@macro-vm:3] GotoIf(“SIP/1100-b7705248”, “1?vmx|1”) in new stack – Goto (macro-vm,vmx,1) – Executing [vmx@macro-vm:1] GotoIf(“SIP/1100-b7705248”, “0?s-DIRECTDIAL|1”) in new stack – Executing [vmx@macro-vm:2] Set(“SIP/1100-b7705248”, “MODE=unavail”) in new stack – Executing [vmx@macro-vm:3] GotoIf(“SIP/1100-b7705248”, “0?notdirect”) in new stack – Executing [vmx@macro-vm:4] Set(“SIP/1100-b7705248”, “MODE=unavail”) in new stack – Executing [vmx@macro-vm:5] NoOp(“SIP/1100-b7705248”, "Checking if ext 700 is enabled: ") in new stack – Executing [vmx@macro-vm:6] GotoIf(“SIP/1100-b7705248”, “1?s-DIRECTDIAL|1”) in new stack – Goto (macro-vm,s-DIRECTDIAL,1) – Executing [s-DIRECTDIAL@macro-vm:1] NoOp(“SIP/1100-b7705248”, “DIRECTDIAL voicemail”) in new stack – Executing [s-DIRECTDIAL@macro-vm:2] Macro(“SIP/1100-b7705248”, “get-vmcontext|700”) in new stack – Executing [s@macro-get-vmcontext:1] Set(“SIP/1100-b7705248”, “VMCONTEXT=default”) in new stack – Executing [s@macro-get-vmcontext:2] GotoIf(“SIP/1100-b7705248”, “0?200:300”) in new stack – Goto (macro-get-vmcontext,s,300) – Executing [s@macro-get-vmcontext:300] NoOp(“SIP/1100-b7705248”, “”) in new stack == Spawn extension (macro-vm, s-DIRECTDIAL, 3) exited non-zero on ‘SIP/1100-b7705248’ in macro ‘vm’ == Spawn extension (from-internal, *700, 1) exited non-zero on ‘SIP/1100-b7705248’ – Executing [h@from-internal:1] Macro(“SIP/1100-b7705248”, “hangupcall”) in new stack – Executing [s@macro-hangupcall:1] ResetCDR(“SIP/1100-b7705248”, “w”) in new stack – Executing [s@macro-hangupcall:2] NoCDR(“SIP/1100-b7705248”, “”) in new stack – Executing [s@macro-hangupcall:3] GotoIf(“SIP/1100-b7705248”, “1?skiprg”) in new stack – Goto (macro-hangupcall,s,6) – Executing [s@macro-hangupcall:6] GotoIf(“SIP/1100-b7705248”, “1?skipblkvm”) in new stack – Goto (macro-hangupcall,s,9) – Executing [s@macro-hangupcall:9] GotoIf(“SIP/1100-b7705248”, “1?theend”) in new stack – Goto (macro-hangupcall,s,11) – Executing [s@macro-hangupcall:11] Hangup(“SIP/1100-b7705248”, “”) in new stack == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/1100-b7705248’ in macro ‘hangupcall’ == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1100-b7705248’

Checking VM:


    -- Executing [*98@from-internal:1] Answer("SIP/1100-b770b490", "") in new stack
    -- Executing [*98@from-internal:2] Wait("SIP/1100-b770b490", "1") in new stack
    -- Executing [*98@from-internal:3] NoOp("SIP/1100-b770b490", "app-dialvm: Asking for mailbox") in new stack
    -- Executing [*98@from-internal:4] Read("SIP/1100-b770b490", "MAILBOX|vm-login|||3|2") in new stack
    --  Playing 'vm-login' (language 'en')
  == Parsing '/etc/asterisk/manager.conf': Found
  == Parsing '/etc/asterisk/manager_additional.conf': Found
  == Parsing '/etc/asterisk/manager_custom.conf': Found
  == Parsing '/etc/asterisk/manager.conf': Found
  == Parsing '/etc/asterisk/manager_additional.conf': Found
  == Parsing '/etc/asterisk/manager_custom.conf': Found
  == Parsing '/etc/asterisk/manager.conf': Found
  == Parsing '/etc/asterisk/manager_additional.conf': Found
  == Parsing '/etc/asterisk/manager_custom.conf': Found
    -- User entered '315'
    -- Executing [*98@from-internal:5] NoOp("SIP/1100-b770b490", "app-dialvm: Got Mailbox 315") in new stack
    -- Executing [*98@from-internal:6] Macro("SIP/1100-b770b490", "get-vmcontext|315") in new stack
    -- Executing [s@macro-get-vmcontext:1] Set("SIP/1100-b770b490", "VMCONTEXT=default") in new stack
    -- Executing [s@macro-get-vmcontext:2] GotoIf("SIP/1100-b770b490", "0?200:300") in new stack
    -- Goto (macro-get-vmcontext,s,300)
    -- Executing [s@macro-get-vmcontext:300] NoOp("SIP/1100-b770b490", "") in new stack
  == Spawn extension (from-internal, *98, 7) exited non-zero on 'SIP/1100-b770b490'
    -- Executing [h@from-internal:1] Macro("SIP/1100-b770b490", "hangupcall") in new stack
    -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/1100-b770b490", "w") in new stack
    -- Executing [s@macro-hangupcall:2] NoCDR("SIP/1100-b770b490", "") in new stack
    -- Executing [s@macro-hangupcall:3] GotoIf("SIP/1100-b770b490", "1?skiprg") in new stack
    -- Goto (macro-hangupcall,s,6)
    -- Executing [s@macro-hangupcall:6] GotoIf("SIP/1100-b770b490", "1?skipblkvm") in new stack
    -- Goto (macro-hangupcall,s,9)
    -- Executing [s@macro-hangupcall:9] GotoIf("SIP/1100-b770b490", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,11)
    -- Executing [s@macro-hangupcall:11] Hangup("SIP/1100-b770b490", "") in new stack
  == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/1100-b770b490' in macro 'hangupcall'
  == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/1100-b770b490'

namotco · March 25, 2009, 4:57pm

Here is some more info:
From AsteriskNOW 1.5b1
FreePBX 2.5.1.2

Modules:
Feature Code Adminsetup2.5.0.4Enabled
FreePBX ARI Frameworksetup2.5.2.2Enabled
FreePBX FOP Frameworksetup2.5.0.1Enabled
FreePBX Frameworksetup2.5.1.2Enabled
FreePBX Localization Updatessetup2.5.1.3Enabled
System Dashboardtool2.5.0.6Enabled
Voicemailsetup2.5.1.6Enabled
CID & Number Management

Phonebook Directorytool2.5.0.1Enabled
Speed Dial Functionsmodule2.5.0.1Enabled
Inbound Call Control

Announcementssetup2.5.1.8Enabled
Blacklistsetup2.5.0.5Enabled
Caller ID Lookupsetup2.5.0.6Enabled
Day Night Modesetup2.5.0.12Enabled
Follow Mesetup2.5.1.8Enabled
IVRsetup2.5.20.6Enabled
Queue Prioritiessetup2.5.0.5Enabled
Queuessetup2.5.4.6Enabled
Ring Groupssetup2.5.1.8Enabled
Time Conditionssetup2.5.0.9Enabled
Internal Options & Configuration

Call Forwardsetup2.5.0.2Enabled
Call Waitingsetup2.5.0.1Enabled
Callbacksetup2.5.0.3Enabled
Conferencessetup2.5.1.7Enabled
DISAsetup2.5.1.7Enabled
Dictationsetup2.5.0.3Enabled
Do-Not-Disturb (DND)setup2.5.0.6Enabled
Info Servicessetup2.5.0.2Enabled
Languagessetup2.5.0.8Enabled
Misc Applicationssetup2.5.0.4Enabled
Misc Destinationssetup2.5.0.3Enabled
Music on Holdsetup2.5.1.3Enabled
PIN Setssetup2.5.0.2Enabled
Paging and Intercomsetup2.5.0.7Enabled
Parking Lotsetup2.5.1.4Enabled
Recordingssetup3.3.8.9Enabled
VoiceMail Blastingsetup2.5.0.5Enabled
Support

Asterisk Logfilestool2.5.0.1Enabled
Online Supporttool2.5.0.2Enabled
System Administration

Asterisk APItool2.5.0.2Enabled
Asterisk CLItool2.5.0.3Enabled
Asterisk Infotool2.5.0.2Enabled
Backup & Restoretool2.5.1.6Enabled
Custom Applicationstool2.5.0.5Enabled
DUNDi Lookup Registrytool2.5.0.1Enabled
Java SSHtool2.5.0.2Enabled
PHP Infotool2.5.0Enabled
PHPAGI Configtool2.5.0.3Enabled
Phonebooktool2.5.0.3Enabled
Third Party Addon

Customer DBtool2.5.0.4Enabled
Gabcasttool2.5.0.2Enabled
Inventorytool2.5.0.2Enabled
Print Extensionstool2.5.0.4Enabled

fskrotzki · March 25, 2009, 3:49pm

you have a error " == Spawn extension (from-internal, *98, 7) exited non-zero on ‘SIP/1100-b770b490’" but past that it’s hard to tell.

Please see: http://freepbx.org/forum/freepbx/installation/so-you-have-a-problem-and-want-help and provide as much details as possible. It can be one of several things based on how your system is configured.

Permissions problem? you just upgraded something and found a bug? upgraded but not to the latest and came across a bug that’s been fixed, etc…

But without knowing anything about your system we are taking a shot in the dark on providing any kind of meaning full answer to your situation.

fskrotzki · March 25, 2009, 5:29pm

Great, that helps, I know the issue and have the solution.

First off make sure you upgrade all your modules to the latest 2.5.x code to start, don’t stay at the versions you are at now. Use the module admin, go online and get all updates.

There was a bug with version of FreePBX that comes with AsteriskNow 1.5b1 and b2 for voicemail and I’m going to guess that you where running that version (I don’t have the version number handy).

The bug was that it placed a empty context line in the voicemail.conf file, which breaks voicemail, it’s been fixed BUT once that line is in it nothing will remove it (as it should not occure) and requires a manual edit of the file to fix it.

So edit /etc/asterisk/voicemail.conf and you will find at least one (possibly more) line that is nothing but:

[]
delete them and the problem will go away.

namotco · March 25, 2009, 6:11pm

I’ve updated all the modules via module admin.

Still not working…

Here is my /etc/asterisk/voicemail.conf:

;!
;! Automatically generated configuration file
;! Filename: voicemail.conf (/etc/asterisk/voicemail.conf)
;! Generator: AppVoicemail
;! Creation Date: Tue Jan 6 17:02:09 2009
;!
[general]
; 1st listed format gets emailed
format = wav49|wav
attach = yes
pbxskip = yes ; Don’t put [PBX]: in the subject line
serveremail = vm@asterisk ; Who the e-mail notification should appear to come from
fromstring = Voicemail System ; Real name of email sender
maxmessage = 180 ; max length of vm message
minmessage = 3 ; Minimum length of a voicemail message in seconds
maxsilence = 5 ; Wait for 5 silent seconds and end the voicemail
silencethreshold = 128 ; What do we consider to be silence
skipms = 3000 ; How many miliseconds to skip forward/back when rew/ff in message playback
review = yes ; Allow sender to review/rerecord their message before saving it
operator = yes ; Allow caller to press 0
nextaftercmd = yes ; Automagically play next message when current message is deleted or saved
; Change the email body, variables: VM_NAME, VM_DUR, VM_MSGNUM, VM_MAILBOX, VM_CALLERID, VM_DATE
emailbody = ${VM_NAME},\n\nThere is a new voicemail in mailbox ${VM_MAILBOX}:\n\n\tFrom:\t${VM_CALLERID}\n\tLength:\t${VM_DUR} seconds\n\tDate:\t${VM_DATE}\n\nDial *98 to access your voicemail by phone.\nVisit http://192.168.1.201/recordings/index.php to check your voicemail with a web browser.\n

fskrotzki · March 25, 2009, 6:15pm

ok I’ve not run the Beta 1, but have Beta 2 running and the file should NOT look that way.

The default file to start should look more like this:

[general]                   
#include vm_general.inc     
#include vm_email.inc       
[default]

namotco · March 25, 2009, 7:55pm

It turns out the voice mail module wasn’t loaded after I did the mysql_addon (which upgraded the core asterisk as a dependancy). I couldn’t grab it from packages.asterisk.org (down) so I took it from the AsteriskNOW 1.5b2 CD and did an RPM install (not yum).