[asterisk-users] voicemail didn't send voice message to my email

fateme fatah faza_404 at yahoo.com
Sun Jun 22 04:25:01 CDT 2008 

Hi :
asterisk didn't send voice message to my mail(fatemefatah2000 at yahoo.com).My main configured files are:
extensions.conf:
[from-pstn]
exten => 9711315,1,Dial(SIP/3000,30)
exten => 9711315,2,VoiceMail(3000 at ff_tutorial)
exten => 9711315,3,PlayBack(vm-goodbye)
exten => 9711315,4,HangUp()
sip.conf:
[3000]
type=friend
username=3000
secret=1234567
host=dynamic
context=from-pstn
mailbox=3000 at ff_tutorial
voicemail.conf:
[ff_tutorial]
3000 => 1234567,3000,fatemefatah2000 at yahoo.com

And these are in console:

Jun 29 12:08:11 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
    -- Accepting call from '3322000' to '9711315' on channel 0/1, span 1
Jun 29 12:08:15 DEBUG[24207]: chan_zap.c:1554 zt_enable_ec: Enabled echo cancellation on channel 1
    -- Executing Dial("Zap/1-1", "SIP/3000|30") in new stack
Jun 29 12:08:15 DEBUG[24257]: chan_sip.c:1889 create_addr_from_peer: Setting NAT on RTP to 0
Jun 29 12:08:15 DEBUG[24257]: chan_sip.c:2085 sip_call: Outgoing Call for 3000
    -- Called 3000
Jun 29 12:08:16 DEBUG[24203]: chan_sip.c:1468 __sip_semi_ack: (Provisional) Stopping retransmission (but retaining packet) on '3f4c7d54725d24f1635f9b920f5c6508 at 192.168.200.65' Request 102: Found
    -- SIP/3000-08941d28 is ringing
Jun 29 12:08:16 DEBUG[24257]: chan_zap.c:4981 zt_indicate: Requested indication 3 on channel Zap/1-1
Jun 29 12:08:21 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
Jun 29 12:08:31 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
Jun 29 12:08:41 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
    -- Nobody picked up in 30000 ms
Jun 29 12:08:47 DEBUG[24257]: chan_zap.c:4981 zt_indicate: Requested indication -1 on channel Zap/1-1
Jun 29 12:08:47 DEBUG[24257]: chan_sip.c:2450 sip_hangup: update_call_counter(3000) - decrement call limit counter
Jun 29 12:08:47 DEBUG[24257]: chan_sip.c:1392 __sip_ack: Acked pending invite 102
Jun 29 12:08:47 DEBUG[24257]: chan_sip.c:1415 __sip_ack: Stopping retransmission on '3f4c7d54725d24f1635f9b920f5c6508 at 192.168.200.65' of Request 102: Match Found
Jun 29 12:08:47 DEBUG[24257]: app_dial.c:1661 dial_exec_full: Exiting with DIALSTATUS=NOANSWER.
    -- Executing VoiceMail("Zap/1-1", "3000 at ff_tutorial") in new stack
Jun 29 12:08:47 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 160 sample intervals
    -- Playing 'vm-intro' (language 'en')
Jun 29 12:08:47 DEBUG[24203]: chan_sip.c:1415 __sip_ack: Stopping retransmission on '3f4c7d54725d24f1635f9b920f5c6508 at 192.168.200.65' of Request 102: Match Found
Jun 29 12:08:47 DEBUG[24203]: chan_sip.c:1415 __sip_ack: Stopping retransmission on '3f4c7d54725d24f1635f9b920f5c6508 at 192.168.200.65' of Request 102: Match Not Found
Jun 29 12:08:51 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
Jun 29 12:08:52 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
Jun 29 12:08:52 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
Jun 29 12:08:52 DEBUG[24257]: app.c:1235 ast_lock_path: Locked path '/var/spool/asterisk/voicemail/ff_tutorial/3000/INBOX'
Jun 29 12:08:52 DEBUG[24257]: app.c:1256 ast_unlock_path: Unlocked path '/var/spool/asterisk/voicemail/ff_tutorial/3000/INBOX'
Jun 29 12:08:52 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 160 sample intervals
    -- Playing 'beep' (language 'en')
Jun 29 12:08:53 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
Jun 29 12:08:53 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
    -- Recording the message
Jun 29 12:08:53 DEBUG[24257]: app.c:568 ast_play_and_record_full: play_and_record: <None>, /var/spool/asterisk/voicemail/ff_tutorial/3000/tmp/GE15v9, 'wav49|gsm|wav'
Jun 29 12:08:53 DEBUG[24257]: app.c:585 ast_play_and_record_full: Recording Formats: sfmts=wav49
    -- x=0, open writing:  /var/spool/asterisk/voicemail/ff_tutorial/3000/tmp/GE15v9 format: wav49, 0x88b0f48
    -- x=1, open writing:  /var/spool/asterisk/voicemail/ff_tutorial/3000/tmp/GE15v9 format: gsm, 0x88b12a0
    -- x=2, open writing:  /var/spool/asterisk/voicemail/ff_tutorial/3000/tmp/GE15v9 format: wav, 0x88b15e0
Jun 29 12:08:53 DEBUG[24257]: chan_zap.c:4981 zt_indicate: Requested indication 18 on channel Zap/1-1
Jun 29 12:09:01 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
Jun 29 12:09:11 DEBUG[24257]: chan_zap.c:3669 zt_handle_dtmfup: DTMF digit: # on Zap/1-1
    -- User ended message by pressing #
Jun 29 12:09:11 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 160 sample intervals
    -- Playing 'auth-thankyou' (language 'en')
Jun 29 12:09:11 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
Jun 29 12:09:12 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
Jun 29 12:09:12 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
Jun 29 12:09:12 DEBUG[24257]: app.c:1235 ast_lock_path: Locked path '/var/spool/asterisk/voicemail/ff_tutorial/3000/INBOX'
Jun 29 12:09:12 DEBUG[24257]: app.c:1256 ast_unlock_path: Unlocked path '/var/spool/asterisk/voicemail/ff_tutorial/3000/INBOX'
Jun 29 12:09:12 DEBUG[24257]: app_voicemail.c:1695 sendmail: Attaching file '/var/spool/asterisk/voicemail/ff_tutorial/3000/INBOX/msg0011', format 'WAV', uservm is '2048', global is 2048
Jun 29 12:09:12 DEBUG[24257]: app_voicemail.c:1832 sendmail: Sent mail to fatemefatah2000 at yahoo.com with command '/usr/sbin/sendmail -t'
    -- Executing Playback("Zap/1-1", "vm-goodbye") in new stack
Jun 29 12:09:12 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 160 sample intervals
    -- Playing 'vm-goodbye' (language 'en')
Jun 29 12:09:18 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
Jun 29 12:09:18 DEBUG[24257]: channel.c:1777 ast_settimeout: Scheduling timer at 0 sample intervals
    -- Executing Hangup("Zap/1-1", "") in new stack
  == Spawn extension (from-pstn, 9711315, 4) exited non-zero on 'Zap/1-1'
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:3015 zt_setoption: Set option AUDIO MODE, value: ON(1) on Zap/1-1
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:2496 zt_hangup: Hangup: channel: 1 index = 0, normal = 19, callwait = -1, thirdcall = -1
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:2645 zt_hangup: Not yet hungup...  Calling hangup once with icause, and clearing call
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 1
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:2936 zt_setoption: Set option TDD MODE, value: OFF(0) on Zap/1-1
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:1523 update_conf: Updated conferencing on 1, with 0 conference users
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:3011 zt_setoption: Set option AUDIO MODE, value: OFF(0) on Zap/1-1
Jun 29 12:09:18 DEBUG[24257]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 1
    -- Hungup 'Zap/1-1'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '3322000'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '3322000'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '9711315'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is 'from-pstn'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is 'Zap/1-1'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is 'SIP/3000-08941d28'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is 'Hangup'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '2008-06-29 12:08:15'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '2008-06-29 12:08:47'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '2008-06-29 12:09:18'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '63'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '31'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is 'ANSWERED'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is 'DOCUMENTATION'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '1214728695.0'
Jun 29 12:09:18 DEBUG[24257]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 29 12:09:21 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0
Jun 29 12:09:22 DEBUG[24203]: chan_sip.c:1415 __sip_ack: Stopping retransmission on '02b2d2de37422458059ff58f0b0cf1d6 at 192.168.200.65' of Request 102: Match Found
Jun 29 12:09:31 WARNING[24207]: chan_zap.c:8093 zt_pri_error: Call Reference Length not supported: 0





      
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.digium.com/pipermail/asterisk-users/attachments/20080622/900ebdcb/attachment.htm

More information about the asterisk-users mailing list