vgetty/vm shell

• Messages sorted by:[ date ][ thread ][ subject ][ author ]

On Thu, 3 Sep 1998, Marc SCHAEFER wrote:

> Joerg Friedrich <Joerg.Dieter.Friedrich@uni-konstanz.de> wrote:
> > I don't know why, but vm seems not to recognize DTMF-tones. i.e. in the
> > dtmf.sh script dtmfs don't cause an event. 
> 
> Maybe you have a log file for us ? :)
oops, sorry :-)
 
> It's not at all easy to help you since we do not know:
>    - operating system
Linux (Debian 2.0)

>    - modem type
Zyxel 2864id
>    - mgetty/vgetty version
1.1.17 (with the patch Gert posted yesterday to fix msn-mapping )

>    - a few lines out of the log file
Here you are:
I added some comments to show what I did:
--
09/03 12:39:00 yS1  vgetty: experimental test release 0.8.1 / 25Mar98
09/03 12:39:00 yS1  mgetty: experimental test release 1.1.17-Aug07
09/03 12:39:00 yS1  reading generic configuration from config file /etc/mgetty/voice.conf
09/03 12:39:00 yS1   reading /etc/mgetty/voice.conf...
09/03 12:39:00 yS1   conf lib: read: 'part generic'
09/03 12:39:00 yS1   section: part generic, **found**
09/03 12:39:00 yS1   conf lib: read: 'voice_log_level 6'
09/03 12:39:00 yS1   conf lib: read: 'phone_owner root'
09/03 12:39:00 yS1   conf lib: read: 'phone_group voice'
09/03 12:39:00 yS1   conf lib: read: 'voice_dir /var/spool/voice'
09/03 12:39:00 yS1   conf lib: read: 'message_flag_file .flag'
09/03 12:39:00 yS1   conf lib: read: 'receive_dir incoming'
09/03 12:39:00 yS1   conf lib: read: 'message_dir messages'
09/03 12:39:00 yS1   conf lib: read: 'message_list Index'
09/03 12:39:00 yS1   conf lib: read: 'backup_message standard.rmd'
09/03 12:39:00 yS1   conf lib: read: 'port_speed 38400'
09/03 12:39:00 yS1   conf lib: read: 'voice_shell /bin/sh'
09/03 12:39:00 yS1   conf lib: read: 'port_timeout 10'
09/03 12:39:00 yS1   conf lib: read: 'dial_timeout 90'
09/03 12:39:00 yS1   conf lib: read: 'command_delay 100'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_len 30'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_threshold 40'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_wait 7'
09/03 12:39:00 yS1   conf lib: read: 'ignore_fax_dle false'
09/03 12:39:00 yS1   conf lib: read: 'raw_data false'
09/03 12:39:00 yS1   conf lib: read: 'rec_compression 4'
09/03 12:39:00 yS1   conf lib: read: 'rec_speed 11025'
09/03 12:39:00 yS1   conf lib: read: 'rec_silence_len 70'
09/03 12:39:00 yS1   conf lib: read: 'rec_silence_threshold 40'
09/03 12:39:00 yS1   conf lib: read: 'rec_remove_silence true'
09/03 12:39:00 yS1   conf lib: read: 'rec_max_len 300'
09/03 12:39:00 yS1   conf lib: read: 'rec_min_len 0'
09/03 12:39:00 yS1   conf lib: read: 'do_hard_flow true'
09/03 12:39:00 yS1   conf lib: read: 'beep_frequency 933'
09/03 12:39:00 yS1   conf lib: read: 'beep_length 150'
09/03 12:39:00 yS1   conf lib: read: 'max_tries 3'
09/03 12:39:00 yS1   conf lib: read: 'retry_delay 5'
09/03 12:39:00 yS1   conf lib: read: 'watchdog_timeout 30'
09/03 12:39:00 yS1   conf lib: read: 'receive_gain -1'
09/03 12:39:00 yS1   conf lib: read: 'transmit_gain -1'
09/03 12:39:00 yS1   conf lib: read: 'enable_command_echo true'
09/03 12:39:00 yS1   conf lib: read: 'program vgetty'
09/03 12:39:00 yS1   found CT_KEYWORD program vgetty
09/03 12:39:00 yS1   conf lib: read: 'force_autodetect false'
09/03 12:39:00 yS1   conf lib: read: 'rec_always_keep false'
09/03 12:39:00 yS1   conf lib: read: 'button_program button.sh'
09/03 12:39:00 yS1   conf lib: read: 'call_program '
09/03 12:39:00 yS1   conf lib: read: 'dtmf_program dtmf.sh'
09/03 12:39:00 yS1   conf lib: read: 'message_program message.sh'
09/03 12:39:00 yS1   conf lib: read: 'do_message_light true'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:00 yS1   conf lib: read: 'rings 5'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:00 yS1   conf lib: read: 'rings 2'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:00 yS1   conf lib: read: 'program vm'
09/03 12:39:00 yS1   conf lib: read: 'voice_devices ttyS1'
09/03 12:39:00 yS1   conf lib: read: 'dialout_timeout 90'
09/03 12:39:00 yS1   conf lib: read: 'program pvf'
09/03 12:39:00 yS1   conf lib: read: 'port ttyS1'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:00 yS1   conf lib: read: 'rings 5'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:00 yS1   conf lib: read: 'rings 2'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:00 yS1   key: 'part', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'program', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'port', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'voice_log_level', type=0, flags=3, data=6
09/03 12:39:00 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
09/03 12:39:00 yS1   key: 'port_speed', type=0, flags=3, data=38400
09/03 12:39:00 yS1   key: 'port_timeout', type=0, flags=3, data=10
09/03 12:39:00 yS1   key: 'dial_timeout', type=0, flags=3, data=90
09/03 12:39:00 yS1   key: 'command_delay', type=0, flags=3, data=100
09/03 12:39:00 yS1   key: 'dtmf_len', type=0, flags=3, data=30
09/03 12:39:00 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
09/03 12:39:00 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
09/03 12:39:00 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'rec_compression', type=0, flags=3, data=4
09/03 12:39:00 yS1   key: 'rec_speed', type=0, flags=3, data=11025
09/03 12:39:00 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
09/03 12:39:00 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
09/03 12:39:00 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'rec_max_len', type=0, flags=3, data=300
09/03 12:39:00 yS1   key: 'rec_min_len', type=0, flags=3, data=0
09/03 12:39:00 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'force_autodetect', type=3, flags=1, data=FALSE
09/03 12:39:00 yS1   key: 'watchdog_timeout', type=0, flags=3, data=30
09/03 12:39:00 yS1   key: 'receive_gain', type=0, flags=3, data=-1
09/03 12:39:00 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
09/03 12:39:00 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'poll_interval', type=0, flags=1, data=10
09/03 12:39:00 yS1   key: 'rings', type=1, flags=1, data=3
09/03 12:39:00 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
09/03 12:39:00 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
09/03 12:39:00 yS1   key: 'rec_always_keep', type=3, flags=1, data=TRUE
09/03 12:39:00 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
09/03 12:39:00 yS1   key: 'phone_owner', type=1, flags=3, data=root
09/03 12:39:00 yS1   key: 'phone_group', type=1, flags=3, data=voice
09/03 12:39:00 yS1   key: 'phone_mode', type=0, flags=1, data=432
09/03 12:39:00 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
09/03 12:39:00 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
09/03 12:39:00 yS1   key: 'message_dir', type=1, flags=3, data=messages
09/03 12:39:00 yS1   key: 'message_list', type=1, flags=3, data=Index
09/03 12:39:00 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
09/03 12:39:00 yS1   key: 'button_program', type=1, flags=1, data=
09/03 12:39:00 yS1   key: 'call_program', type=1, flags=1, data=
09/03 12:39:00 yS1   key: 'dtmf_program', type=1, flags=1, data=dtmf.sh
09/03 12:39:00 yS1   key: 'message_program', type=1, flags=1, data=
09/03 12:39:00 yS1   key: 'do_message_light', type=3, flags=1, data=FALSE
09/03 12:39:00 yS1   key: 'beep_frequency', type=0, flags=3, data=933
09/03 12:39:00 yS1   key: 'beep_length', type=0, flags=3, data=150
09/03 12:39:00 yS1   key: 'max_tries', type=0, flags=3, data=3
09/03 12:39:00 yS1   key: 'retry_delay', type=0, flags=3, data=5
09/03 12:39:00 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
09/03 12:39:00 yS1   key: 'voice_devices', type=1, flags=1, data=
09/03 12:39:00 yS1  reading program vgetty configuration from config file /etc/mgetty/voice.conf
09/03 12:39:00 yS1   reading /etc/mgetty/voice.conf...
09/03 12:39:00 yS1   conf lib: read: 'part generic'
09/03 12:39:00 yS1   found CT_KEYWORD part generic
09/03 12:39:00 yS1   conf lib: read: 'voice_log_level 6'
09/03 12:39:00 yS1   conf lib: read: 'phone_owner root'
09/03 12:39:00 yS1   conf lib: read: 'phone_group voice'
09/03 12:39:00 yS1   conf lib: read: 'voice_dir /var/spool/voice'
09/03 12:39:00 yS1   conf lib: read: 'message_flag_file .flag'
09/03 12:39:00 yS1   conf lib: read: 'receive_dir incoming'
09/03 12:39:00 yS1   conf lib: read: 'message_dir messages'
09/03 12:39:00 yS1   conf lib: read: 'message_list Index'
09/03 12:39:00 yS1   conf lib: read: 'backup_message standard.rmd'
09/03 12:39:00 yS1   conf lib: read: 'port_speed 38400'
09/03 12:39:00 yS1   conf lib: read: 'voice_shell /bin/sh'
09/03 12:39:00 yS1   conf lib: read: 'port_timeout 10'
09/03 12:39:00 yS1   conf lib: read: 'dial_timeout 90'
09/03 12:39:00 yS1   conf lib: read: 'command_delay 100'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_len 30'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_threshold 40'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_wait 7'
09/03 12:39:00 yS1   conf lib: read: 'ignore_fax_dle false'
09/03 12:39:00 yS1   conf lib: read: 'raw_data false'
09/03 12:39:00 yS1   conf lib: read: 'rec_compression 4'
09/03 12:39:00 yS1   conf lib: read: 'rec_speed 11025'
09/03 12:39:00 yS1   conf lib: read: 'rec_silence_len 70'
09/03 12:39:00 yS1   conf lib: read: 'rec_silence_threshold 40'
09/03 12:39:00 yS1   conf lib: read: 'rec_remove_silence true'
09/03 12:39:00 yS1   conf lib: read: 'rec_max_len 300'
09/03 12:39:00 yS1   conf lib: read: 'rec_min_len 0'
09/03 12:39:00 yS1   conf lib: read: 'do_hard_flow true'
09/03 12:39:00 yS1   conf lib: read: 'beep_frequency 933'
09/03 12:39:00 yS1   conf lib: read: 'beep_length 150'
09/03 12:39:00 yS1   conf lib: read: 'max_tries 3'
09/03 12:39:00 yS1   conf lib: read: 'retry_delay 5'
09/03 12:39:00 yS1   conf lib: read: 'watchdog_timeout 30'
09/03 12:39:00 yS1   conf lib: read: 'receive_gain -1'
09/03 12:39:00 yS1   conf lib: read: 'transmit_gain -1'
09/03 12:39:00 yS1   conf lib: read: 'enable_command_echo true'
09/03 12:39:00 yS1   conf lib: read: 'program vgetty'
09/03 12:39:00 yS1   section: program vgetty, **found**
09/03 12:39:00 yS1   conf lib: read: 'force_autodetect false'
09/03 12:39:00 yS1   conf lib: read: 'rec_always_keep false'
09/03 12:39:00 yS1   conf lib: read: 'button_program button.sh'
09/03 12:39:00 yS1   conf lib: read: 'call_program '
09/03 12:39:00 yS1   conf lib: read: 'dtmf_program dtmf.sh'
09/03 12:39:00 yS1   conf lib: read: 'message_program message.sh'
09/03 12:39:00 yS1   conf lib: read: 'do_message_light true'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:00 yS1   found CT_KEYWORD ring_type ring1
09/03 12:39:00 yS1   conf lib: read: 'rings 5'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:00 yS1   conf lib: read: 'rings 2'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:00 yS1   conf lib: read: 'program vm'
09/03 12:39:00 yS1   section: program vm, ignore
09/03 12:39:00 yS1   conf lib: read: 'voice_devices ttyS1'
09/03 12:39:00 yS1   conf lib: read: 'dialout_timeout 90'
09/03 12:39:00 yS1   conf lib: read: 'program pvf'
09/03 12:39:00 yS1   section: program pvf, ignore
09/03 12:39:00 yS1   conf lib: read: 'port ttyS1'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:00 yS1   conf lib: read: 'rings 5'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:00 yS1   conf lib: read: 'rings 2'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:00 yS1   key: 'part', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'program', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'port', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'voice_log_level', type=0, flags=3, data=6
09/03 12:39:00 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
09/03 12:39:00 yS1   key: 'port_speed', type=0, flags=3, data=38400
09/03 12:39:00 yS1   key: 'port_timeout', type=0, flags=3, data=10
09/03 12:39:00 yS1   key: 'dial_timeout', type=0, flags=3, data=90
09/03 12:39:00 yS1   key: 'command_delay', type=0, flags=3, data=100
09/03 12:39:00 yS1   key: 'dtmf_len', type=0, flags=3, data=30
09/03 12:39:00 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
09/03 12:39:00 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
09/03 12:39:00 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'rec_compression', type=0, flags=3, data=4
09/03 12:39:00 yS1   key: 'rec_speed', type=0, flags=3, data=11025
09/03 12:39:00 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
09/03 12:39:00 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
09/03 12:39:00 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'rec_max_len', type=0, flags=3, data=300
09/03 12:39:00 yS1   key: 'rec_min_len', type=0, flags=3, data=0
09/03 12:39:00 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'watchdog_timeout', type=0, flags=3, data=30
09/03 12:39:00 yS1   key: 'receive_gain', type=0, flags=3, data=-1
09/03 12:39:00 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
09/03 12:39:00 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'poll_interval', type=0, flags=1, data=10
09/03 12:39:00 yS1   key: 'rings', type=1, flags=1, data=3
09/03 12:39:00 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
09/03 12:39:00 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
09/03 12:39:00 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
09/03 12:39:00 yS1   key: 'phone_owner', type=1, flags=3, data=root
09/03 12:39:00 yS1   key: 'phone_group', type=1, flags=3, data=voice
09/03 12:39:00 yS1   key: 'phone_mode', type=0, flags=1, data=432
09/03 12:39:00 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
09/03 12:39:00 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
09/03 12:39:00 yS1   key: 'message_dir', type=1, flags=3, data=messages
09/03 12:39:00 yS1   key: 'message_list', type=1, flags=3, data=Index
09/03 12:39:00 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
09/03 12:39:00 yS1   key: 'button_program', type=1, flags=3, data=button.sh
09/03 12:39:00 yS1   key: 'call_program', type=1, flags=3, data=
09/03 12:39:00 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
09/03 12:39:00 yS1   key: 'message_program', type=1, flags=3, data=message.sh
09/03 12:39:00 yS1   key: 'do_message_light', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'beep_frequency', type=0, flags=3, data=933
09/03 12:39:00 yS1   key: 'beep_length', type=0, flags=3, data=150
09/03 12:39:00 yS1   key: 'max_tries', type=0, flags=3, data=3
09/03 12:39:00 yS1   key: 'retry_delay', type=0, flags=3, data=5
09/03 12:39:00 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
09/03 12:39:00 yS1   key: 'voice_devices', type=1, flags=1, data=
09/03 12:39:00 yS1  reading port ttyS1 configuration from config file /etc/mgetty/voice.conf
09/03 12:39:00 yS1   reading /etc/mgetty/voice.conf...
09/03 12:39:00 yS1   conf lib: read: 'part generic'
09/03 12:39:00 yS1   found CT_KEYWORD part generic
09/03 12:39:00 yS1   conf lib: read: 'voice_log_level 6'
09/03 12:39:00 yS1   conf lib: read: 'phone_owner root'
09/03 12:39:00 yS1   conf lib: read: 'phone_group voice'
09/03 12:39:00 yS1   conf lib: read: 'voice_dir /var/spool/voice'
09/03 12:39:00 yS1   conf lib: read: 'message_flag_file .flag'
09/03 12:39:00 yS1   conf lib: read: 'receive_dir incoming'
09/03 12:39:00 yS1   conf lib: read: 'message_dir messages'
09/03 12:39:00 yS1   conf lib: read: 'message_list Index'
09/03 12:39:00 yS1   conf lib: read: 'backup_message standard.rmd'
09/03 12:39:00 yS1   conf lib: read: 'port_speed 38400'
09/03 12:39:00 yS1   conf lib: read: 'voice_shell /bin/sh'
09/03 12:39:00 yS1   conf lib: read: 'port_timeout 10'
09/03 12:39:00 yS1   conf lib: read: 'dial_timeout 90'
09/03 12:39:00 yS1   conf lib: read: 'command_delay 100'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_len 30'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_threshold 40'
09/03 12:39:00 yS1   conf lib: read: 'dtmf_wait 7'
09/03 12:39:00 yS1   conf lib: read: 'ignore_fax_dle false'
09/03 12:39:00 yS1   conf lib: read: 'raw_data false'
09/03 12:39:00 yS1   conf lib: read: 'rec_compression 4'
09/03 12:39:00 yS1   conf lib: read: 'rec_speed 11025'
09/03 12:39:00 yS1   conf lib: read: 'rec_silence_len 70'
09/03 12:39:00 yS1   conf lib: read: 'rec_silence_threshold 40'
09/03 12:39:00 yS1   conf lib: read: 'rec_remove_silence true'
09/03 12:39:00 yS1   conf lib: read: 'rec_max_len 300'
09/03 12:39:00 yS1   conf lib: read: 'rec_min_len 0'
09/03 12:39:00 yS1   conf lib: read: 'do_hard_flow true'
09/03 12:39:00 yS1   conf lib: read: 'beep_frequency 933'
09/03 12:39:00 yS1   conf lib: read: 'beep_length 150'
09/03 12:39:00 yS1   conf lib: read: 'max_tries 3'
09/03 12:39:00 yS1   conf lib: read: 'retry_delay 5'
09/03 12:39:00 yS1   conf lib: read: 'watchdog_timeout 30'
09/03 12:39:00 yS1   conf lib: read: 'receive_gain -1'
09/03 12:39:00 yS1   conf lib: read: 'transmit_gain -1'
09/03 12:39:00 yS1   conf lib: read: 'enable_command_echo true'
09/03 12:39:00 yS1   conf lib: read: 'program vgetty'
09/03 12:39:00 yS1   conf lib: read: 'force_autodetect false'
09/03 12:39:00 yS1   conf lib: read: 'rec_always_keep false'
09/03 12:39:00 yS1   conf lib: read: 'button_program button.sh'
09/03 12:39:00 yS1   conf lib: read: 'call_program '
09/03 12:39:00 yS1   conf lib: read: 'dtmf_program dtmf.sh'
09/03 12:39:00 yS1   conf lib: read: 'message_program message.sh'
09/03 12:39:00 yS1   conf lib: read: 'do_message_light true'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:00 yS1   conf lib: read: 'rings 5'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:00 yS1   conf lib: read: 'rings 2'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:00 yS1   conf lib: read: 'program vm'
09/03 12:39:00 yS1   conf lib: read: 'voice_devices ttyS1'
09/03 12:39:00 yS1   conf lib: read: 'dialout_timeout 90'
09/03 12:39:00 yS1   conf lib: read: 'program pvf'
09/03 12:39:00 yS1   conf lib: read: 'port ttyS1'
09/03 12:39:00 yS1   section: port ttyS1, **found**
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:00 yS1   found CT_KEYWORD ring_type ring1
09/03 12:39:00 yS1   conf lib: read: 'rings 5'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:00 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:00 yS1   conf lib: read: 'rings 2'
09/03 12:39:00 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:00 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:00 yS1   key: 'part', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'program', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'port', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
09/03 12:39:00 yS1   key: 'voice_log_level', type=0, flags=3, data=6
09/03 12:39:00 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
09/03 12:39:00 yS1   key: 'port_speed', type=0, flags=3, data=38400
09/03 12:39:00 yS1   key: 'port_timeout', type=0, flags=3, data=10
09/03 12:39:00 yS1   key: 'dial_timeout', type=0, flags=3, data=90
09/03 12:39:00 yS1   key: 'command_delay', type=0, flags=3, data=100
09/03 12:39:00 yS1   key: 'dtmf_len', type=0, flags=3, data=30
09/03 12:39:00 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
09/03 12:39:00 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
09/03 12:39:00 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'rec_compression', type=0, flags=3, data=4
09/03 12:39:00 yS1   key: 'rec_speed', type=0, flags=3, data=11025
09/03 12:39:00 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
09/03 12:39:00 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
09/03 12:39:00 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'rec_max_len', type=0, flags=3, data=300
09/03 12:39:00 yS1   key: 'rec_min_len', type=0, flags=3, data=0
09/03 12:39:00 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'watchdog_timeout', type=0, flags=3, data=30
09/03 12:39:00 yS1   key: 'receive_gain', type=0, flags=3, data=-1
09/03 12:39:00 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
09/03 12:39:00 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'poll_interval', type=0, flags=1, data=10
09/03 12:39:00 yS1   key: 'rings', type=1, flags=1, data=3
09/03 12:39:00 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
09/03 12:39:00 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
09/03 12:39:00 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
09/03 12:39:00 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
09/03 12:39:00 yS1   key: 'phone_owner', type=1, flags=3, data=root
09/03 12:39:00 yS1   key: 'phone_group', type=1, flags=3, data=voice
09/03 12:39:00 yS1   key: 'phone_mode', type=0, flags=1, data=432
09/03 12:39:00 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
09/03 12:39:00 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
09/03 12:39:00 yS1   key: 'message_dir', type=1, flags=3, data=messages
09/03 12:39:00 yS1   key: 'message_list', type=1, flags=3, data=Index
09/03 12:39:00 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
09/03 12:39:00 yS1   key: 'button_program', type=1, flags=3, data=button.sh
09/03 12:39:00 yS1   key: 'call_program', type=1, flags=3, data=
09/03 12:39:00 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
09/03 12:39:00 yS1   key: 'message_program', type=1, flags=3, data=message.sh
09/03 12:39:00 yS1   key: 'do_message_light', type=3, flags=3, data=TRUE
09/03 12:39:00 yS1   key: 'beep_frequency', type=0, flags=3, data=933
09/03 12:39:00 yS1   key: 'beep_length', type=0, flags=3, data=150
09/03 12:39:00 yS1   key: 'max_tries', type=0, flags=3, data=3
09/03 12:39:00 yS1   key: 'retry_delay', type=0, flags=3, data=5
09/03 12:39:00 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
09/03 12:39:00 yS1   key: 'voice_devices', type=1, flags=1, data=
09/03 12:39:00 yS1  check for lockfiles
09/03 12:39:00 yS1   checklock: stat failed, no file
09/03 12:39:00 yS1  locking the line
09/03 12:39:00 yS1   makelock(ttyS1) called
09/03 12:39:00 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
09/03 12:39:00 yS1   lock made
09/03 12:39:00 yS1   tio_get_rs232_lines: status: RTS CTS DSR DTR
09/03 12:39:00 yS1  lowering DTR to reset Modem
09/03 12:39:01 yS1   tss: set speed to 38400 (017)
09/03 12:39:01 yS1   tio_set_flow_control( HARD )
09/03 12:39:01 yS1  WARNING: obsolete setserial spd_hi/spd_vhi used, 38400 is not real port speed
09/03 12:39:01 yS1   waiting for line to clear (VTIME), read: 
09/03 12:39:01 yS1  send: \d\d\d+++\d\d\dAT&FS2=255[0d]
09/03 12:39:04 yS1  waiting for ``OK''
09/03 12:39:04 yS1   got: AT&FS2=255[0d]
09/03 12:39:04 yS1    CND: AT&FS2=255[0d][0a]OK ** found **
09/03 12:39:04 yS1  send: ATN3S0=0S13.2=1[0d]
09/03 12:39:04 yS1  waiting for ``OK''
09/03 12:39:04 yS1   got: [0d]
09/03 12:39:04 yS1    CND: OK[0a]ATN3S0=0S13.2=1[0d]
09/03 12:39:04 yS1    CND: ATN3S0=0S13.2=1[0d][0a]OK ** found **
09/03 12:39:04 yS1  send: AT[0d]
09/03 12:39:04 yS1  do_stat: expect 'OK' ** found **
09/03 12:39:04 yS1  send: ATI2[0d]
09/03 12:39:04 yS1  do_stat: expect 'OK' ** found **
09/03 12:39:04 yS1  mdm_send: 'AT+FCLASS=2'
09/03 12:39:04 yS1    got:[0a]AT+FCLASS=2[0d]
09/03 12:39:04 yS1   mdm_command: string 'AT+FCLASS=2'
09/03 12:39:04 yS1    got:[0d][0a]OK[0d]
09/03 12:39:04 yS1   mdm_command: string 'OK' -> OK
09/03 12:39:04 yS1  mdm_send: 'AT+FCLASS=0'
09/03 12:39:04 yS1    got:[0a]AT+FCLASS=0[0d]
09/03 12:39:04 yS1   mdm_command: string 'AT+FCLASS=0'
09/03 12:39:04 yS1    got:[0d][0a]OK[0d]
09/03 12:39:04 yS1   mdm_command: string 'OK' -> OK
09/03 12:39:05 yS1  mdm_send: 'AT+FAA=1;+FCR=1'
09/03 12:39:05 yS1    got:[0a]AT+FAA=1;+FCR=1[0d]
09/03 12:39:05 yS1   mdm_command: string 'AT+FAA=1;+FCR=1'
09/03 12:39:05 yS1    got:[0d][0a]OK[0d]
09/03 12:39:05 yS1   mdm_command: string 'OK' -> OK
09/03 12:39:05 yS1  mdm_send: 'AT+FBOR=0'
09/03 12:39:05 yS1    got:[0a]AT+FBOR=0[0d]
09/03 12:39:05 yS1   mdm_command: string 'AT+FBOR=0'
09/03 12:39:05 yS1    got:[0d][0a]OK[0d]
09/03 12:39:05 yS1   mdm_command: string 'OK' -> OK
09/03 12:39:05 yS1  mdm_send: 'AT+FLID="++49-7531-95137"'
09/03 12:39:05 yS1    got:[0a]AT+FLID="++49-7531-95137"[0d]
09/03 12:39:05 yS1   mdm_command: string 'AT+FLID="++49-7531-95137"'
09/03 12:39:05 yS1    got:[0d][0a]OK[0d]
09/03 12:39:05 yS1   mdm_command: string 'OK' -> OK
09/03 12:39:05 yS1  mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
09/03 12:39:05 yS1    got:[0a]AT+FDCC=1,5,0,2,0,0,0,0[0d]
09/03 12:39:05 yS1   mdm_command: string 'AT+FDCC=1,5,0,2,0,0,0,0'
09/03 12:39:05 yS1    got:[0d][0a]OK[0d]
09/03 12:39:05 yS1   mdm_command: string 'OK' -> OK
09/03 12:39:05 yS1   tss: set speed to 38400 (017)
09/03 12:39:05 yS1   tio_set_flow_control( HARD )
09/03 12:39:05 yS1  detecting voice modem type
09/03 12:39:05 yS1    vgetty: ATE1
09/03 12:39:05 yS1   voice command: '' -> 'OK|ATE1'
09/03 12:39:05 yS1    serial port: ATE1
09/03 12:39:05 yS1    serial port: OK
09/03 12:39:05 yS1   voice command: 'ATI' -> ''
09/03 12:39:05 yS1    vgetty: ATI
09/03 12:39:05 yS1    serial port: ATI
09/03 12:39:05 yS1    serial port: 28642
09/03 12:39:05 yS1    ZyXEL 2864: OK
09/03 12:39:05 yS1  ZyXEL 2864 detected
09/03 12:39:05 yS1   vgetty: entering voice mode
09/03 12:39:05 yS1   vgetty: Installing signal handlers
09/03 12:39:05 yS1   voice command: 'AT+FCLASS?' -> ''
09/03 12:39:06 yS1    vgetty: AT+FCLASS?
09/03 12:39:06 yS1    ZyXEL 2864: AT+FCLASS?
09/03 12:39:06 yS1    ZyXEL 2864: 0
09/03 12:39:06 yS1   voice command: '' -> 'OK'
09/03 12:39:06 yS1    ZyXEL 2864: OK
09/03 12:39:06 yS1   voice command: 'AT+FCLASS=8' -> 'OK'
09/03 12:39:06 yS1    vgetty: AT+FCLASS=8
09/03 12:39:06 yS1    ZyXEL 2864: AT+FCLASS=8
09/03 12:39:06 yS1    ZyXEL 2864: OK
09/03 12:39:06 yS1   voice command: 'AT' -> 'OK'
09/03 12:39:06 yS1    vgetty: AT
09/03 12:39:06 yS1    ZyXEL 2864: AT
09/03 12:39:06 yS1    ZyXEL 2864: OK
09/03 12:39:06 yS1    vgetty: queued event RESET_WATCHDOG at position 0000
09/03 12:39:06 yS1  initializing ZyXEL 2864 voice modem
09/03 12:39:06 yS1   voice command: 'ATS48.5=1' -> 'OK'
09/03 12:39:06 yS1    vgetty: ATS48.5=1
09/03 12:39:06 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0000
09/03 12:39:06 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <
09/03 12:39:06 yS1    ZyXEL 2864: ATS48.5=1
09/03 12:39:06 yS1    ZyXEL 2864: OK
09/03 12:39:06 yS1   voice command: 'ATS40.3=1 S40.4=1 S40.5=1 S40.6=1' -> 'OK'
09/03 12:39:06 yS1    vgetty: ATS40.3=1 S40.4=1 S40.5=1 S40.6=1
09/03 12:39:06 yS1    ZyXEL 2864: ATS40.3=1 S40.4=1 S40.5=1 S40.6=1
09/03 12:39:06 yS1    ZyXEL 2864: OK
09/03 12:39:06 yS1   voice command: 'AT+VIT=100' -> 'OK'
09/03 12:39:06 yS1    vgetty: AT+VIT=100
09/03 12:39:06 yS1    ZyXEL 2864: AT+VIT=100
09/03 12:39:06 yS1    ZyXEL 2864: OK
09/03 12:39:06 yS1   voice command: 'AT+VDD=6,6' -> 'OK'
09/03 12:39:06 yS1    vgetty: AT+VDD=6,6
09/03 12:39:06 yS1    ZyXEL 2864: AT+VDD=6,6
09/03 12:39:06 yS1    ZyXEL 2864: OK
09/03 12:39:06 yS1   voice command: 'AT+VSD=12,70' -> 'OK'
09/03 12:39:07 yS1    vgetty: AT+VSD=12,70
09/03 12:39:07 yS1    ZyXEL 2864: AT+VSD=12,70
09/03 12:39:07 yS1    ZyXEL 2864: OK
09/03 12:39:07 yS1   voice command: 'AT+VGT=128' -> 'OK'
09/03 12:39:07 yS1    vgetty: AT+VGT=128
09/03 12:39:07 yS1    ZyXEL 2864: AT+VGT=128
09/03 12:39:07 yS1    ZyXEL 2864: OK
09/03 12:39:07 yS1   voice command: 'AT+VGR=128' -> 'OK'
09/03 12:39:07 yS1    vgetty: AT+VGR=128
09/03 12:39:07 yS1    ZyXEL 2864: AT+VGR=128
09/03 12:39:07 yS1    ZyXEL 2864: OK
09/03 12:39:07 yS1   vgetty: leaving voice mode
09/03 12:39:07 yS1   voice command: 'AT+FCLASS=0' -> 'OK'
09/03 12:39:07 yS1    vgetty: AT+FCLASS=0
09/03 12:39:07 yS1    ZyXEL 2864: AT+FCLASS=0
09/03 12:39:07 yS1    ZyXEL 2864: OK
09/03 12:39:07 yS1   voice command: 'AT' -> 'OK'
09/03 12:39:07 yS1    vgetty: AT
09/03 12:39:07 yS1    ZyXEL 2864: AT
09/03 12:39:07 yS1    ZyXEL 2864: OK
09/03 12:39:07 yS1   vgetty: Restoring signal handlers
09/03 12:39:07 yS1    vgetty: checking for message flag file /var/spool/voice/.flag
09/03 12:39:07 yS1   voice command: 'ATS0=0' -> 'OK'
09/03 12:39:07 yS1    vgetty: ATS0=0
09/03 12:39:07 yS1    ZyXEL 2864: ATS0=0
09/03 12:39:07 yS1    ZyXEL 2864: OK
09/03 12:39:07 yS1   waiting for line to clear (VTIME), read: 
09/03 12:39:08 yS1   removing lock file
09/03 12:39:08 yS1  waiting...
09/03 12:39:21 yS1    select returned 1
09/03 12:39:21 yS1   checking lockfiles, locking the line
09/03 12:39:21 yS1   makelock(ttyS1) called
09/03 12:39:21 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
09/03 12:39:21 yS1   lock made
09/03 12:39:21 yS1    vgetty: number of rings (3) was set directly
09/03 12:39:21 yS1  wfr: waiting for ``RING''
09/03 12:39:21 yS1   got: [0a]RING[0d]
09/03 12:39:21 yS1    CND: RING
09/03 12:39:21 yS1   wfr: rc=0, drn=0
09/03 12:39:21 yS1  wfr: waiting for ``RING''
09/03 12:39:21 yS1   got: [0a]FM:753195135 TO:95135[0d]
09/03 12:39:21 yS1    CND: FM:753195135 TO:95135
09/03 12:39:21 yS1    CND: found: 753195135 TO:95135
09/03 12:39:21 yS1  ZyXEL: 'FM:753195135 TO:95135'
09/03 12:39:21 yS1   MSN: '95135'
09/03 12:39:21 yS1    match: '95135'
09/03 12:39:21 yS1   wfr: rc=0, drn=1
09/03 12:39:21 yS1  wfr: waiting for ``RING''
09/03 12:39:21 yS1   got: [0a][0d][0a]RING[0d]
09/03 12:39:27 yS1    CND: RING
09/03 12:39:27 yS1   wfr: rc=0, drn=1
09/03 12:39:27 yS1    CND: check no: '753195135'

I called my modem :-) MSN-Mapping correct


09/03 12:39:27 yS1  reading ring_type ring1 configuration from config file /etc/mgetty/voice.conf
09/03 12:39:27 yS1   reading /etc/mgetty/voice.conf...
09/03 12:39:27 yS1   conf lib: read: 'part generic'
09/03 12:39:27 yS1   found CT_KEYWORD part generic
09/03 12:39:27 yS1   conf lib: read: 'voice_log_level 6'
09/03 12:39:27 yS1   conf lib: read: 'phone_owner root'
09/03 12:39:27 yS1   conf lib: read: 'phone_group voice'
09/03 12:39:27 yS1   conf lib: read: 'voice_dir /var/spool/voice'
09/03 12:39:27 yS1   conf lib: read: 'message_flag_file .flag'
09/03 12:39:27 yS1   conf lib: read: 'receive_dir incoming'
09/03 12:39:27 yS1   conf lib: read: 'message_dir messages'
09/03 12:39:27 yS1   conf lib: read: 'message_list Index'
09/03 12:39:27 yS1   conf lib: read: 'backup_message standard.rmd'
09/03 12:39:27 yS1   conf lib: read: 'port_speed 38400'
09/03 12:39:27 yS1   conf lib: read: 'voice_shell /bin/sh'
09/03 12:39:27 yS1   conf lib: read: 'port_timeout 10'
09/03 12:39:27 yS1   conf lib: read: 'dial_timeout 90'
09/03 12:39:27 yS1   conf lib: read: 'command_delay 100'
09/03 12:39:27 yS1   conf lib: read: 'dtmf_len 30'
09/03 12:39:27 yS1   conf lib: read: 'dtmf_threshold 40'
09/03 12:39:27 yS1   conf lib: read: 'dtmf_wait 7'
09/03 12:39:27 yS1   conf lib: read: 'ignore_fax_dle false'
09/03 12:39:27 yS1   conf lib: read: 'raw_data false'
09/03 12:39:27 yS1   conf lib: read: 'rec_compression 4'
09/03 12:39:27 yS1   conf lib: read: 'rec_speed 11025'
09/03 12:39:27 yS1   conf lib: read: 'rec_silence_len 70'
09/03 12:39:27 yS1   conf lib: read: 'rec_silence_threshold 40'
09/03 12:39:27 yS1   conf lib: read: 'rec_remove_silence true'
09/03 12:39:27 yS1   conf lib: read: 'rec_max_len 300'
09/03 12:39:27 yS1   conf lib: read: 'rec_min_len 0'
09/03 12:39:27 yS1   conf lib: read: 'do_hard_flow true'
09/03 12:39:27 yS1   conf lib: read: 'beep_frequency 933'
09/03 12:39:27 yS1   conf lib: read: 'beep_length 150'
09/03 12:39:27 yS1   conf lib: read: 'max_tries 3'
09/03 12:39:27 yS1   conf lib: read: 'retry_delay 5'
09/03 12:39:27 yS1   conf lib: read: 'watchdog_timeout 30'
09/03 12:39:27 yS1   conf lib: read: 'receive_gain -1'
09/03 12:39:27 yS1   conf lib: read: 'transmit_gain -1'
09/03 12:39:27 yS1   conf lib: read: 'enable_command_echo true'
09/03 12:39:27 yS1   conf lib: read: 'program vgetty'
09/03 12:39:27 yS1   conf lib: read: 'force_autodetect false'
09/03 12:39:27 yS1   conf lib: read: 'rec_always_keep false'
09/03 12:39:27 yS1   conf lib: read: 'button_program button.sh'
09/03 12:39:27 yS1   conf lib: read: 'call_program '
09/03 12:39:27 yS1   conf lib: read: 'dtmf_program dtmf.sh'
09/03 12:39:27 yS1   conf lib: read: 'message_program message.sh'
09/03 12:39:27 yS1   conf lib: read: 'do_message_light true'
09/03 12:39:27 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:27 yS1   section: ring_type ring1, **found**
09/03 12:39:27 yS1   conf lib: read: 'rings 5'
09/03 12:39:27 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:27 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:27 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:27 yS1   section: ring_type ring3, ignore
09/03 12:39:27 yS1   conf lib: read: 'rings 2'
09/03 12:39:27 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:27 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:27 yS1   conf lib: read: 'program vm'
09/03 12:39:27 yS1   conf lib: read: 'voice_devices ttyS1'
09/03 12:39:27 yS1   conf lib: read: 'dialout_timeout 90'
09/03 12:39:27 yS1   conf lib: read: 'program pvf'
09/03 12:39:27 yS1   conf lib: read: 'port ttyS1'
09/03 12:39:27 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:27 yS1   section: ring_type ring1, **found**
09/03 12:39:27 yS1   conf lib: read: 'rings 5'
09/03 12:39:27 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:27 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:27 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:27 yS1   section: ring_type ring3, ignore
09/03 12:39:27 yS1   conf lib: read: 'rings 2'
09/03 12:39:27 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:27 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:27 yS1   key: 'part', type=6, flags=4, data=(ignored)
09/03 12:39:27 yS1   key: 'program', type=6, flags=4, data=(ignored)
09/03 12:39:27 yS1   key: 'port', type=6, flags=4, data=(ignored)
09/03 12:39:27 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
09/03 12:39:27 yS1   key: 'voice_log_level', type=0, flags=3, data=6
09/03 12:39:27 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
09/03 12:39:27 yS1   key: 'port_speed', type=0, flags=3, data=38400
09/03 12:39:27 yS1   key: 'port_timeout', type=0, flags=3, data=10
09/03 12:39:27 yS1   key: 'dial_timeout', type=0, flags=3, data=90
09/03 12:39:27 yS1   key: 'command_delay', type=0, flags=3, data=100
09/03 12:39:27 yS1   key: 'dtmf_len', type=0, flags=3, data=30
09/03 12:39:27 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
09/03 12:39:27 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
09/03 12:39:27 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
09/03 12:39:27 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
09/03 12:39:27 yS1   key: 'rec_compression', type=0, flags=3, data=4
09/03 12:39:27 yS1   key: 'rec_speed', type=0, flags=3, data=11025
09/03 12:39:27 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
09/03 12:39:27 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
09/03 12:39:27 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
09/03 12:39:27 yS1   key: 'rec_max_len', type=0, flags=3, data=300
09/03 12:39:27 yS1   key: 'rec_min_len', type=0, flags=3, data=0
09/03 12:39:27 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
09/03 12:39:27 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
09/03 12:39:27 yS1   key: 'watchdog_timeout', type=0, flags=3, data=30
09/03 12:39:27 yS1   key: 'receive_gain', type=0, flags=3, data=50
09/03 12:39:27 yS1   key: 'transmit_gain', type=0, flags=3, data=50
09/03 12:39:27 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
09/03 12:39:27 yS1   key: 'poll_interval', type=0, flags=1, data=10
09/03 12:39:27 yS1   key: 'rings', type=1, flags=3, data=5
09/03 12:39:27 yS1   key: 'answer_mode', type=1, flags=3, data=voice
09/03 12:39:27 yS1   key: 'toll_saver_rings', type=0, flags=3, data=1
09/03 12:39:27 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
09/03 12:39:27 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
09/03 12:39:27 yS1   key: 'phone_owner', type=1, flags=3, data=root
09/03 12:39:27 yS1   key: 'phone_group', type=1, flags=3, data=voice
09/03 12:39:27 yS1   key: 'phone_mode', type=0, flags=1, data=432
09/03 12:39:27 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
09/03 12:39:27 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
09/03 12:39:27 yS1   key: 'message_dir', type=1, flags=3, data=messages
09/03 12:39:27 yS1   key: 'message_list', type=1, flags=3, data=Index
09/03 12:39:27 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
09/03 12:39:27 yS1   key: 'button_program', type=1, flags=3, data=button.sh
09/03 12:39:27 yS1   key: 'call_program', type=1, flags=3, data=
09/03 12:39:27 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
09/03 12:39:27 yS1   key: 'message_program', type=1, flags=3, data=message.sh
09/03 12:39:27 yS1   key: 'do_message_light', type=3, flags=3, data=TRUE
09/03 12:39:27 yS1   key: 'beep_frequency', type=0, flags=3, data=933
09/03 12:39:27 yS1   key: 'beep_length', type=0, flags=3, data=150
09/03 12:39:27 yS1   key: 'max_tries', type=0, flags=3, data=3
09/03 12:39:27 yS1   key: 'retry_delay', type=0, flags=3, data=5
09/03 12:39:27 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
09/03 12:39:27 yS1   key: 'voice_devices', type=1, flags=1, data=
09/03 12:39:27 yS1    vgetty: answer mode was set directly
09/03 12:39:27 yS1    vgetty: answer mode is [voice]

vgetty plays standard-msg. correct.

09/03 12:39:27 yS1    vgetty: opening list file /var/spool/voice/messages/Index
09/03 12:39:27 yS1    vgetty: message name is /var/spool/voice/messages/standard.rmd
09/03 12:39:27 yS1   vgetty: entering voice mode
09/03 12:39:27 yS1   vgetty: Installing signal handlers
09/03 12:39:27 yS1   voice command: 'AT+FCLASS?' -> ''
09/03 12:39:27 yS1    vgetty: AT+FCLASS?
09/03 12:39:27 yS1    ZyXEL 2864: AT+FCLASS?
09/03 12:39:27 yS1    ZyXEL 2864: 0
09/03 12:39:27 yS1   voice command: '' -> 'OK'
09/03 12:39:27 yS1    ZyXEL 2864: OK
09/03 12:39:27 yS1   voice command: 'AT+FCLASS=8' -> 'OK'
09/03 12:39:28 yS1    vgetty: AT+FCLASS=8
09/03 12:39:28 yS1    ZyXEL 2864: AT+FCLASS=8
09/03 12:39:28 yS1    ZyXEL 2864: OK
09/03 12:39:28 yS1   voice command: 'AT' -> 'OK'
09/03 12:39:28 yS1    vgetty: AT
09/03 12:39:28 yS1    ZyXEL 2864: AT
09/03 12:39:28 yS1    ZyXEL 2864: OK
09/03 12:39:28 yS1    vgetty: queued event RESET_WATCHDOG at position 0001
09/03 12:39:28 yS1   voice command: 'AT+VLS=2' -> 'OK'
09/03 12:39:28 yS1    vgetty: AT+VLS=2
09/03 12:39:28 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0001
09/03 12:39:28 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:28 yS1    ZyXEL 2864: AT+VLS=2
09/03 12:39:28 yS1    ZyXEL 2864: OK
09/03 12:39:28 yS1    vgetty: queued event RESET_WATCHDOG at position 0002
09/03 12:39:28 yS1   voice command: 'AT+VLS=2' -> 'OK|CONNECT'
09/03 12:39:28 yS1    vgetty: AT+VLS=2
09/03 12:39:28 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0002
09/03 12:39:28 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:28 yS1    ZyXEL 2864: AT+VLS=2
09/03 12:39:28 yS1    ZyXEL 2864: OK
09/03 12:39:28 yS1  playing voice file /var/spool/voice/messages/standard.rmd
09/03 12:39:28 yS1   vgetty: raw modem data header found
09/03 12:39:28 yS1   vgetty: modem type ZyXEL 2864 found
09/03 12:39:28 yS1   vgetty: compression method 0x0004, speed 11025, bits 4
09/03 12:39:28 yS1    vgetty: queued event RESET_WATCHDOG at position 0003
09/03 12:39:28 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:28 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:28 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0003
09/03 12:39:28 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:28 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:28 yS1    ZyXEL 2864: OK
09/03 12:39:28 yS1    vgetty: queued event RESET_WATCHDOG at position 0004
09/03 12:39:28 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0004
09/03 12:39:28 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:28 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:28 yS1    vgetty: AT+FLO=2
09/03 12:39:28 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:28 yS1    ZyXEL 2864: OK
09/03 12:39:28 yS1   tio_set_flow_control( HARD XON_OUT )
09/03 12:39:28 yS1   voice command: 'AT+VTX' -> 'CONNECT'
09/03 12:39:29 yS1    vgetty: AT+VTX
09/03 12:39:29 yS1    ZyXEL 2864: AT+VTX
09/03 12:39:29 yS1    ZyXEL 2864: CONNECT

I don't know why i always have buffer underrun. I just ignore this :-)

09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:29 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:29 yS1  vgetty: Buffer underrun
09/03 12:39:31 yS1    ZyXEL 2864: <DLE> <*>

I started to enter a WRONG code. vgetty recognizes the dtmf

09/03 12:39:31 yS1    vgetty: queued event RECEIVED_DTMF at position 0005
09/03 12:39:31 yS1    vgetty: unqueued event RECEIVED_DTMF at position 0005
09/03 12:39:31 yS1    vgetty: voice_handle_event got event RECEIVED_DTMF with data <*>
09/03 12:39:31 yS1    vgetty: <VOICE DATA 16530 bytes>
09/03 12:39:31 yS1    vgetty: queued event RESET_WATCHDOG at position 0006
09/03 12:39:31 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0006
09/03 12:39:31 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:31 yS1    vgetty: <INTERRUPT PLAY>
09/03 12:39:31 yS1   voice command: '' -> 'OK'
09/03 12:39:31 yS1    ZyXEL 2864: OK
09/03 12:39:31 yS1    vgetty: queued event RESET_WATCHDOG at position 0007
09/03 12:39:31 yS1   voice command: 'AT+VTS=[933,0,15]' -> ''
09/03 12:39:31 yS1    vgetty: AT+VTS=[933,0,15]
09/03 12:39:31 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0007
09/03 12:39:31 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:31 yS1    ZyXEL 2864: AT+VTS=[933,0,15]
09/03 12:39:31 yS1   voice command: '' -> 'OK'
09/03 12:39:31 yS1    ZyXEL 2864: OK
09/03 12:39:31 yS1  recording voice file /var/spool/voice/incoming/va03792.rmd
09/03 12:39:31 yS1    vgetty: queued event RESET_WATCHDOG at position 0008
09/03 12:39:31 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:31 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:31 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0008
09/03 12:39:31 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:31 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:31 yS1    ZyXEL 2864: OK
09/03 12:39:31 yS1    vgetty: queued event RESET_WATCHDOG at position 0009
09/03 12:39:31 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0009
09/03 12:39:31 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:31 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:31 yS1    vgetty: AT+FLO=2
09/03 12:39:31 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:32 yS1    ZyXEL 2864: OK
09/03 12:39:32 yS1   tio_set_flow_control( HARD XON_IN )
09/03 12:39:32 yS1   voice command: 'AT+VRX' -> 'CONNECT'
09/03 12:39:32 yS1    vgetty: AT+VRX
09/03 12:39:32 yS1    ZyXEL 2864: AT+VRX
09/03 12:39:32 yS1    ZyXEL 2864: CONNECT
09/03 12:39:32 yS1    ZyXEL 2864: <DLE> <0>
09/03 12:39:32 yS1    vgetty: queued event RECEIVED_DTMF at position 0010
09/03 12:39:32 yS1    vgetty: unqueued event RECEIVED_DTMF at position 0010
09/03 12:39:32 yS1    vgetty: voice_handle_event got event RECEIVED_DTMF with data <0>
09/03 12:39:32 yS1    ZyXEL 2864: <DLE> <2>
09/03 12:39:32 yS1    vgetty: queued event RECEIVED_DTMF at position 0011
09/03 12:39:32 yS1    vgetty: unqueued event RECEIVED_DTMF at position 0011
09/03 12:39:32 yS1    vgetty: voice_handle_event got event RECEIVED_DTMF with data <2>
09/03 12:39:33 yS1    ZyXEL 2864: <DLE> <4>
09/03 12:39:33 yS1    vgetty: queued event RECEIVED_DTMF at position 0012
09/03 12:39:33 yS1    vgetty: unqueued event RECEIVED_DTMF at position 0012
09/03 12:39:33 yS1    vgetty: voice_handle_event got event RECEIVED_DTMF with data <4>
09/03 12:39:34 yS1    ZyXEL 2864: <DLE> <#>
09/03 12:39:34 yS1    vgetty: queued event RECEIVED_DTMF at position 0013
09/03 12:39:34 yS1    vgetty: unqueued event RECEIVED_DTMF at position 0013
09/03 12:39:34 yS1    vgetty: voice_handle_event got event RECEIVED_DTMF with data <#>
09/03 12:39:34 yS1    vgetty: <STOP RECORDING>
09/03 12:39:34 yS1    ZyXEL 2864: <VOICE DATA 10811 bytes>
09/03 12:39:34 yS1    ZyXEL 2864: <DLE> <ETX>
09/03 12:39:34 yS1   voice command: '' -> 'OK'
09/03 12:39:34 yS1    ZyXEL 2864: OK
09/03 12:39:34 yS1    vgetty: removing message /var/spool/voice/incoming/va03792.rmd
09/03 12:39:34 ##### got DTMF code - executing DTMF program, name='', caller=753195135, dev=ttyS1, pid=3792

vgetty starts dtmf.sh (which i append at the end of this Mail)

09/03 12:39:34 yS1  vgetty: Executing shell script /var/spool/voice/dtmf.sh with shell /bin/sh
09/03 12:39:34 yS1    vgetty: opening pipes
09/03 12:39:34 yS1    vgetty: forking shell
09/03 12:39:34 yS1   vgetty(0): HELLO SHELL
09/03 12:39:34 yS1    vgetty: Got pipe signal
09/03 12:39:34 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0014
09/03 12:39:34 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0014
09/03 12:39:34 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:34 yS1   shell(1): HELLO VOICE PROGRAM
09/03 12:39:34 yS1   vgetty(1): READY
09/03 12:39:34 yS1   vgetty: initialized communication
09/03 12:39:34 yS1    vgetty: Got pipe signal
09/03 12:39:34 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0015
09/03 12:39:34 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0015
09/03 12:39:34 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:34 yS1   shell(1): BEEP 1320 100
09/03 12:39:34 yS1   vgetty(1): BEEPING
09/03 12:39:34 yS1    vgetty: queued event RESET_WATCHDOG at position 0016
09/03 12:39:34 yS1   voice command: 'AT+VTS=[1320,0,10]' -> ''
09/03 12:39:34 yS1    vgetty: AT+VTS=[1320,0,10]
09/03 12:39:34 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0016
09/03 12:39:34 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:34 yS1    ZyXEL 2864: AT+VTS=[1320,0,10]
09/03 12:39:34 yS1   voice command: '' -> 'OK'
09/03 12:39:34 yS1    ZyXEL 2864: OK
09/03 12:39:34 yS1   vgetty(1): READY
09/03 12:39:34 yS1    vgetty: Got pipe signal
09/03 12:39:34 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0017
09/03 12:39:34 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0017
09/03 12:39:34 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>

dtmf.sh says WRONG code. Correct :-)

09/03 12:39:34 yS1   shell(1): PLAY /var/spool/voice/messages/incorrect.rmd
09/03 12:39:34 yS1   vgetty(1): PLAYING
09/03 12:39:34 yS1  playing voice file /var/spool/voice/messages/incorrect.rmd
09/03 12:39:34 yS1   vgetty: raw modem data header found
09/03 12:39:34 yS1   vgetty: modem type ZyXEL 2864 found
09/03 12:39:34 yS1   vgetty: compression method 0x0004, speed 11025, bits 4
09/03 12:39:34 yS1    vgetty: queued event RESET_WATCHDOG at position 0018
09/03 12:39:34 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:34 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:34 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0018
09/03 12:39:34 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:34 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:34 yS1    ZyXEL 2864: OK
09/03 12:39:34 yS1    vgetty: queued event RESET_WATCHDOG at position 0019
09/03 12:39:34 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0019
09/03 12:39:34 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:34 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:35 yS1    vgetty: AT+FLO=2
09/03 12:39:35 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:35 yS1    ZyXEL 2864: OK
09/03 12:39:35 yS1   tio_set_flow_control( HARD XON_OUT )
09/03 12:39:35 yS1   voice command: 'AT+VTX' -> 'CONNECT'
09/03 12:39:35 yS1    vgetty: AT+VTX
09/03 12:39:35 yS1    ZyXEL 2864: AT+VTX
09/03 12:39:35 yS1    ZyXEL 2864: CONNECT
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:35 yS1  vgetty: Buffer underrun
09/03 12:39:35 yS1    vgetty: <VOICE DATA 7332 bytes>
09/03 12:39:35 yS1    vgetty: queued event RESET_WATCHDOG at position 0020
09/03 12:39:35 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0020
09/03 12:39:35 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:35 yS1    vgetty: <STOP PLAY>
09/03 12:39:35 yS1   voice command: '' -> 'OK'
09/03 12:39:35 yS1    ZyXEL 2864: OK
09/03 12:39:36 yS1   vgetty(1): READY
09/03 12:39:36 yS1    vgetty: Got pipe signal
09/03 12:39:36 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0021
09/03 12:39:36 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0021
09/03 12:39:36 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>

dtmf.sh asks to re-enter the code  correct.

09/03 12:39:36 yS1   shell(1): PLAY /var/spool/voice/messages/get-code.rmd
09/03 12:39:36 yS1   vgetty(1): PLAYING
09/03 12:39:36 yS1  playing voice file /var/spool/voice/messages/get-code.rmd
09/03 12:39:36 yS1   vgetty: raw modem data header found
09/03 12:39:36 yS1   vgetty: modem type ZyXEL 2864 found
09/03 12:39:36 yS1   vgetty: compression method 0x0004, speed 11025, bits 4
09/03 12:39:36 yS1    vgetty: queued event RESET_WATCHDOG at position 0022
09/03 12:39:36 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:36 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:36 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0022
09/03 12:39:36 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:36 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:36 yS1    ZyXEL 2864: OK
09/03 12:39:36 yS1    vgetty: queued event RESET_WATCHDOG at position 0023
09/03 12:39:36 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0023
09/03 12:39:36 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:36 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:36 yS1    vgetty: AT+FLO=2
09/03 12:39:36 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:36 yS1    ZyXEL 2864: OK
09/03 12:39:36 yS1   tio_set_flow_control( HARD XON_OUT )
09/03 12:39:36 yS1   voice command: 'AT+VTX' -> 'CONNECT'
09/03 12:39:36 yS1    vgetty: AT+VTX
09/03 12:39:36 yS1    ZyXEL 2864: AT+VTX
09/03 12:39:36 yS1    ZyXEL 2864: CONNECT
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:36 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:36 yS1  vgetty: Buffer underrun
09/03 12:39:37 yS1    vgetty: <VOICE DATA 9537 bytes>
09/03 12:39:37 yS1    vgetty: queued event RESET_WATCHDOG at position 0024
09/03 12:39:37 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0024
09/03 12:39:37 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:37 yS1    vgetty: <STOP PLAY>
09/03 12:39:37 yS1   voice command: '' -> 'OK'
09/03 12:39:37 yS1    ZyXEL 2864: OK
09/03 12:39:38 yS1   vgetty(1): READY
09/03 12:39:38 yS1    vgetty: Got pipe signal
09/03 12:39:38 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0025
09/03 12:39:38 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0025
09/03 12:39:38 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:38 yS1   shell(1): BEEP 1320 100
09/03 12:39:38 yS1   vgetty(1): BEEPING
09/03 12:39:38 yS1    vgetty: queued event RESET_WATCHDOG at position 0026
09/03 12:39:38 yS1   voice command: 'AT+VTS=[1320,0,10]' -> ''
09/03 12:39:38 yS1    vgetty: AT+VTS=[1320,0,10]
09/03 12:39:38 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0026
09/03 12:39:38 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:38 yS1    ZyXEL 2864: AT+VTS=[1320,0,10]
09/03 12:39:38 yS1   voice command: '' -> 'OK'
09/03 12:39:38 yS1    ZyXEL 2864: OK
09/03 12:39:38 yS1   vgetty(1): READY
09/03 12:39:38 yS1    vgetty: Got pipe signal
09/03 12:39:38 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0027
09/03 12:39:38 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0027
09/03 12:39:38 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:38 yS1   shell(1): ENABLE EVENTS

dtmf.sh enables events and waits. correct.
i tried to reenter a number but this will not recognized as a event.
PROBLEM!!!!

09/03 12:39:38 yS1   vgetty(1): READY
09/03 12:39:38 yS1    vgetty: Got pipe signal
09/03 12:39:38 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0028
09/03 12:39:38 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0028
09/03 12:39:38 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:38 yS1   shell(1): WAIT 5
09/03 12:39:38 yS1   vgetty(1): WAITING
09/03 12:39:38 yS1    vgetty: queued event RESET_WATCHDOG at position 0029
09/03 12:39:38 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0029
09/03 12:39:38 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:38 yS1    vgetty: queued event RESET_WATCHDOG at position 0030
09/03 12:39:38 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0030
09/03 12:39:38 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:44 yS1   vgetty(1): READY
09/03 12:39:44 yS1    vgetty: Got pipe signal
09/03 12:39:44 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0031
09/03 12:39:44 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0031
09/03 12:39:44 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:44 yS1   shell(1): DISABLE EVENTS
09/03 12:39:44 yS1   vgetty(1): READY
09/03 12:39:44 yS1    vgetty: Got pipe signal
09/03 12:39:44 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0032
09/03 12:39:44 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0032
09/03 12:39:44 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:44 yS1   shell(1): BEEP 1320 100
09/03 12:39:44 yS1   vgetty(1): BEEPING
09/03 12:39:44 yS1    vgetty: queued event RESET_WATCHDOG at position 0033
09/03 12:39:44 yS1   voice command: 'AT+VTS=[1320,0,10]' -> ''
09/03 12:39:44 yS1    vgetty: AT+VTS=[1320,0,10]
09/03 12:39:44 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0033
09/03 12:39:44 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:44 yS1    ZyXEL 2864: AT+VTS=[1320,0,10]
09/03 12:39:44 yS1   voice command: '' -> 'OK'
09/03 12:39:44 yS1    ZyXEL 2864: OK
09/03 12:39:44 yS1   vgetty(1): READY
09/03 12:39:44 yS1    vgetty: Got pipe signal
09/03 12:39:44 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0034
09/03 12:39:44 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0034
09/03 12:39:44 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:44 yS1   shell(1): PLAY /var/spool/voice/messages/incorrect.rmd
09/03 12:39:44 yS1   vgetty(1): PLAYING
09/03 12:39:44 yS1  playing voice file /var/spool/voice/messages/incorrect.rmd
09/03 12:39:44 yS1   vgetty: raw modem data header found
09/03 12:39:44 yS1   vgetty: modem type ZyXEL 2864 found
09/03 12:39:44 yS1   vgetty: compression method 0x0004, speed 11025, bits 4
09/03 12:39:44 yS1    vgetty: queued event RESET_WATCHDOG at position 0035
09/03 12:39:44 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:44 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:44 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0035
09/03 12:39:44 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:44 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:44 yS1    ZyXEL 2864: OK
09/03 12:39:44 yS1    vgetty: queued event RESET_WATCHDOG at position 0036
09/03 12:39:44 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0036
09/03 12:39:44 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:44 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:44 yS1    vgetty: AT+FLO=2
09/03 12:39:44 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:44 yS1    ZyXEL 2864: OK
09/03 12:39:44 yS1   tio_set_flow_control( HARD XON_OUT )
09/03 12:39:44 yS1   voice command: 'AT+VTX' -> 'CONNECT'
09/03 12:39:44 yS1    vgetty: AT+VTX
09/03 12:39:44 yS1    ZyXEL 2864: AT+VTX
09/03 12:39:44 yS1    ZyXEL 2864: CONNECT
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:45 yS1  vgetty: Buffer underrun
09/03 12:39:45 yS1    vgetty: <VOICE DATA 7332 bytes>
09/03 12:39:45 yS1    vgetty: queued event RESET_WATCHDOG at position 0037
09/03 12:39:45 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0037
09/03 12:39:45 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:45 yS1    vgetty: <STOP PLAY>
09/03 12:39:45 yS1   voice command: '' -> 'OK'
09/03 12:39:45 yS1    ZyXEL 2864: OK
09/03 12:39:45 yS1   vgetty(1): READY
09/03 12:39:45 yS1    vgetty: Got pipe signal
09/03 12:39:45 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0038
09/03 12:39:45 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0038
09/03 12:39:45 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:45 yS1   shell(1): PLAY /var/spool/voice/messages/get-code.rmd
09/03 12:39:45 yS1   vgetty(1): PLAYING
09/03 12:39:45 yS1  playing voice file /var/spool/voice/messages/get-code.rmd
09/03 12:39:45 yS1   vgetty: raw modem data header found
09/03 12:39:45 yS1   vgetty: modem type ZyXEL 2864 found
09/03 12:39:45 yS1   vgetty: compression method 0x0004, speed 11025, bits 4
09/03 12:39:45 yS1    vgetty: queued event RESET_WATCHDOG at position 0039
09/03 12:39:45 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:46 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:46 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0039
09/03 12:39:46 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:46 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:46 yS1    ZyXEL 2864: OK
09/03 12:39:46 yS1    vgetty: queued event RESET_WATCHDOG at position 0040
09/03 12:39:46 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0040
09/03 12:39:46 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:46 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:46 yS1    vgetty: AT+FLO=2
09/03 12:39:46 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:46 yS1    ZyXEL 2864: OK
09/03 12:39:46 yS1   tio_set_flow_control( HARD XON_OUT )
09/03 12:39:46 yS1   voice command: 'AT+VTX' -> 'CONNECT'
09/03 12:39:46 yS1    vgetty: AT+VTX
09/03 12:39:46 yS1    ZyXEL 2864: AT+VTX
09/03 12:39:46 yS1    ZyXEL 2864: CONNECT
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:46 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:46 yS1  vgetty: Buffer underrun
09/03 12:39:47 yS1    vgetty: <VOICE DATA 9537 bytes>
09/03 12:39:47 yS1    vgetty: queued event RESET_WATCHDOG at position 0041
09/03 12:39:47 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0041
09/03 12:39:47 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:47 yS1    vgetty: <STOP PLAY>
09/03 12:39:47 yS1   voice command: '' -> 'OK'
09/03 12:39:47 yS1    ZyXEL 2864: OK
09/03 12:39:47 yS1   vgetty(1): READY
09/03 12:39:47 yS1    vgetty: Got pipe signal
09/03 12:39:47 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0042
09/03 12:39:47 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0042
09/03 12:39:47 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:47 yS1   shell(1): BEEP 1320 100
09/03 12:39:47 yS1   vgetty(1): BEEPING
09/03 12:39:47 yS1    vgetty: queued event RESET_WATCHDOG at position 0043
09/03 12:39:47 yS1   voice command: 'AT+VTS=[1320,0,10]' -> ''
09/03 12:39:47 yS1    vgetty: AT+VTS=[1320,0,10]
09/03 12:39:47 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0043
09/03 12:39:47 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:47 yS1    ZyXEL 2864: AT+VTS=[1320,0,10]
09/03 12:39:47 yS1   voice command: '' -> 'OK'
09/03 12:39:48 yS1    ZyXEL 2864: OK
09/03 12:39:48 yS1   vgetty(1): READY
09/03 12:39:48 yS1    vgetty: Got pipe signal
09/03 12:39:48 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0044
09/03 12:39:48 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0044
09/03 12:39:48 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:48 yS1   shell(1): ENABLE EVENTS
09/03 12:39:48 yS1   vgetty(1): READY
09/03 12:39:48 yS1    vgetty: Got pipe signal
09/03 12:39:48 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0045
09/03 12:39:48 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0045
09/03 12:39:48 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:48 yS1   shell(1): WAIT 5
09/03 12:39:48 yS1   vgetty(1): WAITING
09/03 12:39:48 yS1    vgetty: queued event RESET_WATCHDOG at position 0046
09/03 12:39:48 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0046
09/03 12:39:48 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:48 yS1    vgetty: queued event RESET_WATCHDOG at position 0047
09/03 12:39:48 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0047
09/03 12:39:48 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:54 yS1   vgetty(1): READY
09/03 12:39:54 yS1    vgetty: Got pipe signal
09/03 12:39:54 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0048
09/03 12:39:54 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0048
09/03 12:39:54 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:54 yS1   shell(1): DISABLE EVENTS
09/03 12:39:54 yS1   vgetty(1): READY
09/03 12:39:54 yS1    vgetty: Got pipe signal
09/03 12:39:54 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0049
09/03 12:39:54 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0049
09/03 12:39:54 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:54 yS1   shell(1): BEEP 1320 100
09/03 12:39:54 yS1   vgetty(1): BEEPING
09/03 12:39:54 yS1    vgetty: queued event RESET_WATCHDOG at position 0050
09/03 12:39:54 yS1   voice command: 'AT+VTS=[1320,0,10]' -> ''
09/03 12:39:54 yS1    vgetty: AT+VTS=[1320,0,10]
09/03 12:39:54 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0050
09/03 12:39:54 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:54 yS1    ZyXEL 2864: AT+VTS=[1320,0,10]
09/03 12:39:54 yS1   voice command: '' -> 'OK'
09/03 12:39:54 yS1    ZyXEL 2864: OK
09/03 12:39:54 yS1   vgetty(1): READY
09/03 12:39:54 yS1    vgetty: Got pipe signal
09/03 12:39:54 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0051
09/03 12:39:54 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0051
09/03 12:39:54 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:54 yS1   shell(1): PLAY /var/spool/voice/messages/incorrect.rmd
09/03 12:39:54 yS1   vgetty(1): PLAYING
09/03 12:39:54 yS1  playing voice file /var/spool/voice/messages/incorrect.rmd
09/03 12:39:54 yS1   vgetty: raw modem data header found
09/03 12:39:54 yS1   vgetty: modem type ZyXEL 2864 found
09/03 12:39:54 yS1   vgetty: compression method 0x0004, speed 11025, bits 4
09/03 12:39:54 yS1    vgetty: queued event RESET_WATCHDOG at position 0052
09/03 12:39:54 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:54 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:54 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0052
09/03 12:39:54 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:54 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:54 yS1    ZyXEL 2864: OK
09/03 12:39:54 yS1    vgetty: queued event RESET_WATCHDOG at position 0053
09/03 12:39:54 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0053
09/03 12:39:54 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:54 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:54 yS1    vgetty: AT+FLO=2
09/03 12:39:54 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:54 yS1    ZyXEL 2864: OK
09/03 12:39:54 yS1   tio_set_flow_control( HARD XON_OUT )
09/03 12:39:54 yS1   voice command: 'AT+VTX' -> 'CONNECT'
09/03 12:39:54 yS1    vgetty: AT+VTX
09/03 12:39:54 yS1    ZyXEL 2864: AT+VTX
09/03 12:39:54 yS1    ZyXEL 2864: CONNECT
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:55 yS1  vgetty: Buffer underrun
09/03 12:39:55 yS1    vgetty: <VOICE DATA 7332 bytes>
09/03 12:39:55 yS1    vgetty: queued event RESET_WATCHDOG at position 0054
09/03 12:39:55 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0054
09/03 12:39:55 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:55 yS1    vgetty: <STOP PLAY>
09/03 12:39:55 yS1   voice command: '' -> 'OK'
09/03 12:39:55 yS1    ZyXEL 2864: OK
09/03 12:39:55 yS1   vgetty(1): READY
09/03 12:39:55 yS1    vgetty: Got pipe signal
09/03 12:39:55 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0055
09/03 12:39:55 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0055
09/03 12:39:55 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>

dtmf.sh says maximim tries exeeded and disconnects!

09/03 12:39:55 yS1   shell(1): PLAY /var/spool/voice/messages/goodbye.rmd
09/03 12:39:55 yS1   vgetty(1): PLAYING
09/03 12:39:55 yS1  playing voice file /var/spool/voice/messages/goodbye.rmd
09/03 12:39:55 yS1   vgetty: raw modem data header found
09/03 12:39:55 yS1   vgetty: modem type ZyXEL 2864 found
09/03 12:39:55 yS1   vgetty: compression method 0x0004, speed 11025, bits 4
09/03 12:39:55 yS1    vgetty: queued event RESET_WATCHDOG at position 0056
09/03 12:39:55 yS1   voice command: 'AT+VSM=4,11025' -> 'OK'
09/03 12:39:55 yS1    vgetty: AT+VSM=4,11025
09/03 12:39:55 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0056
09/03 12:39:55 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:55 yS1    ZyXEL 2864: AT+VSM=4,11025
09/03 12:39:55 yS1    ZyXEL 2864: OK
09/03 12:39:55 yS1    vgetty: queued event RESET_WATCHDOG at position 0057
09/03 12:39:55 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0057
09/03 12:39:55 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:55 yS1   voice command: 'AT+FLO=2' -> 'OK'
09/03 12:39:56 yS1    vgetty: AT+FLO=2
09/03 12:39:56 yS1    ZyXEL 2864: AT+FLO=2
09/03 12:39:56 yS1    ZyXEL 2864: OK
09/03 12:39:56 yS1   tio_set_flow_control( HARD XON_OUT )
09/03 12:39:56 yS1   voice command: 'AT+VTX' -> 'CONNECT'
09/03 12:39:56 yS1    vgetty: AT+VTX
09/03 12:39:56 yS1    ZyXEL 2864: AT+VTX
09/03 12:39:56 yS1    ZyXEL 2864: CONNECT
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:56 yS1    ZyXEL 2864: <DLE> <u>
09/03 12:39:56 yS1  vgetty: Buffer underrun
09/03 12:39:57 yS1    vgetty: <VOICE DATA 9923 bytes>
09/03 12:39:57 yS1    vgetty: queued event RESET_WATCHDOG at position 0058
09/03 12:39:57 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0058
09/03 12:39:57 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:57 yS1    vgetty: <STOP PLAY>
09/03 12:39:57 yS1   voice command: '' -> 'OK'
09/03 12:39:57 yS1    ZyXEL 2864: OK
09/03 12:39:57 yS1   vgetty(1): READY
09/03 12:39:57 yS1    vgetty: Got pipe signal
09/03 12:39:57 yS1    vgetty: queued event SIGNAL_SIGPIPE at position 0059
09/03 12:39:57 yS1    vgetty: unqueued event SIGNAL_SIGPIPE at position 0059
09/03 12:39:57 yS1    vgetty: voice_handle_event got event SIGNAL_SIGPIPE with data <_>
09/03 12:39:57 yS1   shell(1): GOODBYE
09/03 12:39:57 yS1   vgetty(1): GOODBYE SHELL
09/03 12:39:57 yS1    vgetty: Got child changed status signal
09/03 12:39:57 yS1    vgetty: queued event SIGNAL_SIGCHLD at position 0060
09/03 12:39:57 yS1   vgetty: shell exited normally with status 0x0000
09/03 12:39:57 yS1    vgetty: queued event RESET_WATCHDOG at position 0061
09/03 12:39:57 yS1   voice command: 'AT+VLS=0' -> 'OK'
09/03 12:39:57 yS1    vgetty: AT+VLS=0
09/03 12:39:57 yS1    vgetty: unqueued event SIGNAL_SIGCHLD at position 0060
09/03 12:39:57 yS1    vgetty: voice_handle_event got event SIGNAL_SIGCHLD with data <_>
09/03 12:39:57 yS1  vgetty: voice_handle_event got unknown event SIGNAL_SIGCHLD with data <_>
09/03 12:39:57 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0061
09/03 12:39:57 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <_>
09/03 12:39:57 yS1    ZyXEL 2864: AT+VLS=0
09/03 12:39:57 yS1    ZyXEL 2864: OK
09/03 12:39:57 yS1   vgetty: leaving voice mode
09/03 12:39:57 yS1   voice command: 'AT+FCLASS=0' -> 'OK'
09/03 12:39:58 yS1    vgetty: AT+FCLASS=0
09/03 12:39:58 yS1    ZyXEL 2864: AT+FCLASS=0
09/03 12:39:58 yS1    ZyXEL 2864: OK
09/03 12:39:58 yS1   voice command: 'AT' -> 'OK'
09/03 12:39:58 yS1    vgetty: AT
09/03 12:39:58 yS1    ZyXEL 2864: AT
09/03 12:39:58 yS1    ZyXEL 2864: OK
09/03 12:39:58 yS1   vgetty: Restoring signal handlers
09/03 12:39:58 yS1  closing voice modem device
09/03 12:39:58 yS1   removing lock file
--
09/03 12:39:58 yS1  vgetty: experimental test release 0.8.1 / 25Mar98
09/03 12:39:58 yS1  mgetty: experimental test release 1.1.17-Aug07
09/03 12:39:58 yS1  reading generic configuration from config file /etc/mgetty/voice.conf
09/03 12:39:58 yS1   reading /etc/mgetty/voice.conf...
09/03 12:39:58 yS1   conf lib: read: 'part generic'
09/03 12:39:58 yS1   section: part generic, **found**
09/03 12:39:58 yS1   conf lib: read: 'voice_log_level 6'
09/03 12:39:58 yS1   conf lib: read: 'phone_owner root'
09/03 12:39:58 yS1   conf lib: read: 'phone_group voice'
09/03 12:39:58 yS1   conf lib: read: 'voice_dir /var/spool/voice'
09/03 12:39:58 yS1   conf lib: read: 'message_flag_file .flag'
09/03 12:39:58 yS1   conf lib: read: 'receive_dir incoming'
09/03 12:39:58 yS1   conf lib: read: 'message_dir messages'
09/03 12:39:58 yS1   conf lib: read: 'message_list Index'
09/03 12:39:58 yS1   conf lib: read: 'backup_message standard.rmd'
09/03 12:39:58 yS1   conf lib: read: 'port_speed 38400'
09/03 12:39:58 yS1   conf lib: read: 'voice_shell /bin/sh'
09/03 12:39:58 yS1   conf lib: read: 'port_timeout 10'
09/03 12:39:58 yS1   conf lib: read: 'dial_timeout 90'
09/03 12:39:58 yS1   conf lib: read: 'command_delay 100'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_len 30'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_threshold 40'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_wait 7'
09/03 12:39:58 yS1   conf lib: read: 'ignore_fax_dle false'
09/03 12:39:58 yS1   conf lib: read: 'raw_data false'
09/03 12:39:58 yS1   conf lib: read: 'rec_compression 4'
09/03 12:39:58 yS1   conf lib: read: 'rec_speed 11025'
09/03 12:39:58 yS1   conf lib: read: 'rec_silence_len 70'
09/03 12:39:58 yS1   conf lib: read: 'rec_silence_threshold 40'
09/03 12:39:58 yS1   conf lib: read: 'rec_remove_silence true'
09/03 12:39:58 yS1   conf lib: read: 'rec_max_len 300'
09/03 12:39:58 yS1   conf lib: read: 'rec_min_len 0'
09/03 12:39:58 yS1   conf lib: read: 'do_hard_flow true'
09/03 12:39:58 yS1   conf lib: read: 'beep_frequency 933'
09/03 12:39:58 yS1   conf lib: read: 'beep_length 150'
09/03 12:39:58 yS1   conf lib: read: 'max_tries 3'
09/03 12:39:58 yS1   conf lib: read: 'retry_delay 5'
09/03 12:39:58 yS1   conf lib: read: 'watchdog_timeout 30'
09/03 12:39:58 yS1   conf lib: read: 'receive_gain -1'
09/03 12:39:58 yS1   conf lib: read: 'transmit_gain -1'
09/03 12:39:58 yS1   conf lib: read: 'enable_command_echo true'
09/03 12:39:58 yS1   conf lib: read: 'program vgetty'
09/03 12:39:58 yS1   found CT_KEYWORD program vgetty
09/03 12:39:58 yS1   conf lib: read: 'force_autodetect false'
09/03 12:39:58 yS1   conf lib: read: 'rec_always_keep false'
09/03 12:39:58 yS1   conf lib: read: 'button_program button.sh'
09/03 12:39:58 yS1   conf lib: read: 'call_program '
09/03 12:39:58 yS1   conf lib: read: 'dtmf_program dtmf.sh'
09/03 12:39:58 yS1   conf lib: read: 'message_program message.sh'
09/03 12:39:58 yS1   conf lib: read: 'do_message_light true'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:58 yS1   conf lib: read: 'rings 5'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:58 yS1   conf lib: read: 'rings 2'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:58 yS1   conf lib: read: 'program vm'
09/03 12:39:58 yS1   conf lib: read: 'voice_devices ttyS1'
09/03 12:39:58 yS1   conf lib: read: 'dialout_timeout 90'
09/03 12:39:58 yS1   conf lib: read: 'program pvf'
09/03 12:39:58 yS1   conf lib: read: 'port ttyS1'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:58 yS1   conf lib: read: 'rings 5'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:58 yS1   conf lib: read: 'rings 2'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:58 yS1   key: 'part', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'program', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'port', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'voice_log_level', type=0, flags=3, data=6
09/03 12:39:58 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
09/03 12:39:58 yS1   key: 'port_speed', type=0, flags=3, data=38400
09/03 12:39:58 yS1   key: 'port_timeout', type=0, flags=3, data=10
09/03 12:39:58 yS1   key: 'dial_timeout', type=0, flags=3, data=90
09/03 12:39:58 yS1   key: 'command_delay', type=0, flags=3, data=100
09/03 12:39:58 yS1   key: 'dtmf_len', type=0, flags=3, data=30
09/03 12:39:58 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
09/03 12:39:58 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
09/03 12:39:58 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'rec_compression', type=0, flags=3, data=4
09/03 12:39:58 yS1   key: 'rec_speed', type=0, flags=3, data=11025
09/03 12:39:58 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
09/03 12:39:58 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
09/03 12:39:58 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'rec_max_len', type=0, flags=3, data=300
09/03 12:39:58 yS1   key: 'rec_min_len', type=0, flags=3, data=0
09/03 12:39:58 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'force_autodetect', type=3, flags=1, data=FALSE
09/03 12:39:58 yS1   key: 'watchdog_timeout', type=0, flags=3, data=30
09/03 12:39:58 yS1   key: 'receive_gain', type=0, flags=3, data=-1
09/03 12:39:58 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
09/03 12:39:58 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'poll_interval', type=0, flags=1, data=10
09/03 12:39:58 yS1   key: 'rings', type=1, flags=1, data=3
09/03 12:39:58 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
09/03 12:39:58 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
09/03 12:39:58 yS1   key: 'rec_always_keep', type=3, flags=1, data=TRUE
09/03 12:39:58 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
09/03 12:39:58 yS1   key: 'phone_owner', type=1, flags=3, data=root
09/03 12:39:58 yS1   key: 'phone_group', type=1, flags=3, data=voice
09/03 12:39:58 yS1   key: 'phone_mode', type=0, flags=1, data=432
09/03 12:39:58 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
09/03 12:39:58 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
09/03 12:39:58 yS1   key: 'message_dir', type=1, flags=3, data=messages
09/03 12:39:58 yS1   key: 'message_list', type=1, flags=3, data=Index
09/03 12:39:58 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
09/03 12:39:58 yS1   key: 'button_program', type=1, flags=1, data=
09/03 12:39:58 yS1   key: 'call_program', type=1, flags=1, data=
09/03 12:39:58 yS1   key: 'dtmf_program', type=1, flags=1, data=dtmf.sh
09/03 12:39:58 yS1   key: 'message_program', type=1, flags=1, data=
09/03 12:39:58 yS1   key: 'do_message_light', type=3, flags=1, data=FALSE
09/03 12:39:58 yS1   key: 'beep_frequency', type=0, flags=3, data=933
09/03 12:39:58 yS1   key: 'beep_length', type=0, flags=3, data=150
09/03 12:39:58 yS1   key: 'max_tries', type=0, flags=3, data=3
09/03 12:39:58 yS1   key: 'retry_delay', type=0, flags=3, data=5
09/03 12:39:58 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
09/03 12:39:58 yS1   key: 'voice_devices', type=1, flags=1, data=
09/03 12:39:58 yS1  reading program vgetty configuration from config file /etc/mgetty/voice.conf
09/03 12:39:58 yS1   reading /etc/mgetty/voice.conf...
09/03 12:39:58 yS1   conf lib: read: 'part generic'
09/03 12:39:58 yS1   found CT_KEYWORD part generic
09/03 12:39:58 yS1   conf lib: read: 'voice_log_level 6'
09/03 12:39:58 yS1   conf lib: read: 'phone_owner root'
09/03 12:39:58 yS1   conf lib: read: 'phone_group voice'
09/03 12:39:58 yS1   conf lib: read: 'voice_dir /var/spool/voice'
09/03 12:39:58 yS1   conf lib: read: 'message_flag_file .flag'
09/03 12:39:58 yS1   conf lib: read: 'receive_dir incoming'
09/03 12:39:58 yS1   conf lib: read: 'message_dir messages'
09/03 12:39:58 yS1   conf lib: read: 'message_list Index'
09/03 12:39:58 yS1   conf lib: read: 'backup_message standard.rmd'
09/03 12:39:58 yS1   conf lib: read: 'port_speed 38400'
09/03 12:39:58 yS1   conf lib: read: 'voice_shell /bin/sh'
09/03 12:39:58 yS1   conf lib: read: 'port_timeout 10'
09/03 12:39:58 yS1   conf lib: read: 'dial_timeout 90'
09/03 12:39:58 yS1   conf lib: read: 'command_delay 100'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_len 30'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_threshold 40'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_wait 7'
09/03 12:39:58 yS1   conf lib: read: 'ignore_fax_dle false'
09/03 12:39:58 yS1   conf lib: read: 'raw_data false'
09/03 12:39:58 yS1   conf lib: read: 'rec_compression 4'
09/03 12:39:58 yS1   conf lib: read: 'rec_speed 11025'
09/03 12:39:58 yS1   conf lib: read: 'rec_silence_len 70'
09/03 12:39:58 yS1   conf lib: read: 'rec_silence_threshold 40'
09/03 12:39:58 yS1   conf lib: read: 'rec_remove_silence true'
09/03 12:39:58 yS1   conf lib: read: 'rec_max_len 300'
09/03 12:39:58 yS1   conf lib: read: 'rec_min_len 0'
09/03 12:39:58 yS1   conf lib: read: 'do_hard_flow true'
09/03 12:39:58 yS1   conf lib: read: 'beep_frequency 933'
09/03 12:39:58 yS1   conf lib: read: 'beep_length 150'
09/03 12:39:58 yS1   conf lib: read: 'max_tries 3'
09/03 12:39:58 yS1   conf lib: read: 'retry_delay 5'
09/03 12:39:58 yS1   conf lib: read: 'watchdog_timeout 30'
09/03 12:39:58 yS1   conf lib: read: 'receive_gain -1'
09/03 12:39:58 yS1   conf lib: read: 'transmit_gain -1'
09/03 12:39:58 yS1   conf lib: read: 'enable_command_echo true'
09/03 12:39:58 yS1   conf lib: read: 'program vgetty'
09/03 12:39:58 yS1   section: program vgetty, **found**
09/03 12:39:58 yS1   conf lib: read: 'force_autodetect false'
09/03 12:39:58 yS1   conf lib: read: 'rec_always_keep false'
09/03 12:39:58 yS1   conf lib: read: 'button_program button.sh'
09/03 12:39:58 yS1   conf lib: read: 'call_program '
09/03 12:39:58 yS1   conf lib: read: 'dtmf_program dtmf.sh'
09/03 12:39:58 yS1   conf lib: read: 'message_program message.sh'
09/03 12:39:58 yS1   conf lib: read: 'do_message_light true'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:58 yS1   found CT_KEYWORD ring_type ring1
09/03 12:39:58 yS1   conf lib: read: 'rings 5'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:58 yS1   conf lib: read: 'rings 2'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:58 yS1   conf lib: read: 'program vm'
09/03 12:39:58 yS1   section: program vm, ignore
09/03 12:39:58 yS1   conf lib: read: 'voice_devices ttyS1'
09/03 12:39:58 yS1   conf lib: read: 'dialout_timeout 90'
09/03 12:39:58 yS1   conf lib: read: 'program pvf'
09/03 12:39:58 yS1   section: program pvf, ignore
09/03 12:39:58 yS1   conf lib: read: 'port ttyS1'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:58 yS1   conf lib: read: 'rings 5'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:58 yS1   conf lib: read: 'rings 2'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:58 yS1   key: 'part', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'program', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'port', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'voice_log_level', type=0, flags=3, data=6
09/03 12:39:58 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
09/03 12:39:58 yS1   key: 'port_speed', type=0, flags=3, data=38400
09/03 12:39:58 yS1   key: 'port_timeout', type=0, flags=3, data=10
09/03 12:39:58 yS1   key: 'dial_timeout', type=0, flags=3, data=90
09/03 12:39:58 yS1   key: 'command_delay', type=0, flags=3, data=100
09/03 12:39:58 yS1   key: 'dtmf_len', type=0, flags=3, data=30
09/03 12:39:58 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
09/03 12:39:58 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
09/03 12:39:58 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'rec_compression', type=0, flags=3, data=4
09/03 12:39:58 yS1   key: 'rec_speed', type=0, flags=3, data=11025
09/03 12:39:58 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
09/03 12:39:58 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
09/03 12:39:58 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'rec_max_len', type=0, flags=3, data=300
09/03 12:39:58 yS1   key: 'rec_min_len', type=0, flags=3, data=0
09/03 12:39:58 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'watchdog_timeout', type=0, flags=3, data=30
09/03 12:39:58 yS1   key: 'receive_gain', type=0, flags=3, data=-1
09/03 12:39:58 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
09/03 12:39:58 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'poll_interval', type=0, flags=1, data=10
09/03 12:39:58 yS1   key: 'rings', type=1, flags=1, data=3
09/03 12:39:58 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
09/03 12:39:58 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
09/03 12:39:58 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
09/03 12:39:58 yS1   key: 'phone_owner', type=1, flags=3, data=root
09/03 12:39:58 yS1   key: 'phone_group', type=1, flags=3, data=voice
09/03 12:39:58 yS1   key: 'phone_mode', type=0, flags=1, data=432
09/03 12:39:58 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
09/03 12:39:58 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
09/03 12:39:58 yS1   key: 'message_dir', type=1, flags=3, data=messages
09/03 12:39:58 yS1   key: 'message_list', type=1, flags=3, data=Index
09/03 12:39:58 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
09/03 12:39:58 yS1   key: 'button_program', type=1, flags=3, data=button.sh
09/03 12:39:58 yS1   key: 'call_program', type=1, flags=3, data=
09/03 12:39:58 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
09/03 12:39:58 yS1   key: 'message_program', type=1, flags=3, data=message.sh
09/03 12:39:58 yS1   key: 'do_message_light', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'beep_frequency', type=0, flags=3, data=933
09/03 12:39:58 yS1   key: 'beep_length', type=0, flags=3, data=150
09/03 12:39:58 yS1   key: 'max_tries', type=0, flags=3, data=3
09/03 12:39:58 yS1   key: 'retry_delay', type=0, flags=3, data=5
09/03 12:39:58 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
09/03 12:39:58 yS1   key: 'voice_devices', type=1, flags=1, data=
09/03 12:39:58 yS1  reading port ttyS1 configuration from config file /etc/mgetty/voice.conf
09/03 12:39:58 yS1   reading /etc/mgetty/voice.conf...
09/03 12:39:58 yS1   conf lib: read: 'part generic'
09/03 12:39:58 yS1   found CT_KEYWORD part generic
09/03 12:39:58 yS1   conf lib: read: 'voice_log_level 6'
09/03 12:39:58 yS1   conf lib: read: 'phone_owner root'
09/03 12:39:58 yS1   conf lib: read: 'phone_group voice'
09/03 12:39:58 yS1   conf lib: read: 'voice_dir /var/spool/voice'
09/03 12:39:58 yS1   conf lib: read: 'message_flag_file .flag'
09/03 12:39:58 yS1   conf lib: read: 'receive_dir incoming'
09/03 12:39:58 yS1   conf lib: read: 'message_dir messages'
09/03 12:39:58 yS1   conf lib: read: 'message_list Index'
09/03 12:39:58 yS1   conf lib: read: 'backup_message standard.rmd'
09/03 12:39:58 yS1   conf lib: read: 'port_speed 38400'
09/03 12:39:58 yS1   conf lib: read: 'voice_shell /bin/sh'
09/03 12:39:58 yS1   conf lib: read: 'port_timeout 10'
09/03 12:39:58 yS1   conf lib: read: 'dial_timeout 90'
09/03 12:39:58 yS1   conf lib: read: 'command_delay 100'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_len 30'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_threshold 40'
09/03 12:39:58 yS1   conf lib: read: 'dtmf_wait 7'
09/03 12:39:58 yS1   conf lib: read: 'ignore_fax_dle false'
09/03 12:39:58 yS1   conf lib: read: 'raw_data false'
09/03 12:39:58 yS1   conf lib: read: 'rec_compression 4'
09/03 12:39:58 yS1   conf lib: read: 'rec_speed 11025'
09/03 12:39:58 yS1   conf lib: read: 'rec_silence_len 70'
09/03 12:39:58 yS1   conf lib: read: 'rec_silence_threshold 40'
09/03 12:39:58 yS1   conf lib: read: 'rec_remove_silence true'
09/03 12:39:58 yS1   conf lib: read: 'rec_max_len 300'
09/03 12:39:58 yS1   conf lib: read: 'rec_min_len 0'
09/03 12:39:58 yS1   conf lib: read: 'do_hard_flow true'
09/03 12:39:58 yS1   conf lib: read: 'beep_frequency 933'
09/03 12:39:58 yS1   conf lib: read: 'beep_length 150'
09/03 12:39:58 yS1   conf lib: read: 'max_tries 3'
09/03 12:39:58 yS1   conf lib: read: 'retry_delay 5'
09/03 12:39:58 yS1   conf lib: read: 'watchdog_timeout 30'
09/03 12:39:58 yS1   conf lib: read: 'receive_gain -1'
09/03 12:39:58 yS1   conf lib: read: 'transmit_gain -1'
09/03 12:39:58 yS1   conf lib: read: 'enable_command_echo true'
09/03 12:39:58 yS1   conf lib: read: 'program vgetty'
09/03 12:39:58 yS1   conf lib: read: 'force_autodetect false'
09/03 12:39:58 yS1   conf lib: read: 'rec_always_keep false'
09/03 12:39:58 yS1   conf lib: read: 'button_program button.sh'
09/03 12:39:58 yS1   conf lib: read: 'call_program '
09/03 12:39:58 yS1   conf lib: read: 'dtmf_program dtmf.sh'
09/03 12:39:58 yS1   conf lib: read: 'message_program message.sh'
09/03 12:39:58 yS1   conf lib: read: 'do_message_light true'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:58 yS1   conf lib: read: 'rings 5'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:58 yS1   conf lib: read: 'rings 2'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:58 yS1   conf lib: read: 'program vm'
09/03 12:39:58 yS1   conf lib: read: 'voice_devices ttyS1'
09/03 12:39:58 yS1   conf lib: read: 'dialout_timeout 90'
09/03 12:39:58 yS1   conf lib: read: 'program pvf'
09/03 12:39:58 yS1   conf lib: read: 'port ttyS1'
09/03 12:39:58 yS1   section: port ttyS1, **found**
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring1'
09/03 12:39:58 yS1   found CT_KEYWORD ring_type ring1
09/03 12:39:58 yS1   conf lib: read: 'rings 5'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 1'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode voice'
09/03 12:39:58 yS1   conf lib: read: 'ring_type ring3'
09/03 12:39:58 yS1   conf lib: read: 'rings 2'
09/03 12:39:58 yS1   conf lib: read: 'toll_saver_rings 0'
09/03 12:39:58 yS1   conf lib: read: 'answer_mode fax'
09/03 12:39:58 yS1   key: 'part', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'program', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'port', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
09/03 12:39:58 yS1   key: 'voice_log_level', type=0, flags=3, data=6
09/03 12:39:58 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
09/03 12:39:58 yS1   key: 'port_speed', type=0, flags=3, data=38400
09/03 12:39:58 yS1   key: 'port_timeout', type=0, flags=3, data=10
09/03 12:39:58 yS1   key: 'dial_timeout', type=0, flags=3, data=90
09/03 12:39:58 yS1   key: 'command_delay', type=0, flags=3, data=100
09/03 12:39:58 yS1   key: 'dtmf_len', type=0, flags=3, data=30
09/03 12:39:58 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
09/03 12:39:58 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
09/03 12:39:58 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'rec_compression', type=0, flags=3, data=4
09/03 12:39:58 yS1   key: 'rec_speed', type=0, flags=3, data=11025
09/03 12:39:58 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
09/03 12:39:58 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
09/03 12:39:58 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'rec_max_len', type=0, flags=3, data=300
09/03 12:39:58 yS1   key: 'rec_min_len', type=0, flags=3, data=0
09/03 12:39:58 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'watchdog_timeout', type=0, flags=3, data=30
09/03 12:39:58 yS1   key: 'receive_gain', type=0, flags=3, data=-1
09/03 12:39:58 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
09/03 12:39:58 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'poll_interval', type=0, flags=1, data=10
09/03 12:39:58 yS1   key: 'rings', type=1, flags=1, data=3
09/03 12:39:58 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
09/03 12:39:58 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
09/03 12:39:58 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
09/03 12:39:58 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
09/03 12:39:58 yS1   key: 'phone_owner', type=1, flags=3, data=root
09/03 12:39:58 yS1   key: 'phone_group', type=1, flags=3, data=voice
09/03 12:39:58 yS1   key: 'phone_mode', type=0, flags=1, data=432
09/03 12:39:58 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
09/03 12:39:58 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
09/03 12:39:58 yS1   key: 'message_dir', type=1, flags=3, data=messages
09/03 12:39:58 yS1   key: 'message_list', type=1, flags=3, data=Index
09/03 12:39:58 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
09/03 12:39:58 yS1   key: 'button_program', type=1, flags=3, data=button.sh
09/03 12:39:58 yS1   key: 'call_program', type=1, flags=3, data=
09/03 12:39:58 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
09/03 12:39:58 yS1   key: 'message_program', type=1, flags=3, data=message.sh
09/03 12:39:58 yS1   key: 'do_message_light', type=3, flags=3, data=TRUE
09/03 12:39:58 yS1   key: 'beep_frequency', type=0, flags=3, data=933
09/03 12:39:58 yS1   key: 'beep_length', type=0, flags=3, data=150
09/03 12:39:58 yS1   key: 'max_tries', type=0, flags=3, data=3
09/03 12:39:58 yS1   key: 'retry_delay', type=0, flags=3, data=5
09/03 12:39:58 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
09/03 12:39:58 yS1   key: 'voice_devices', type=1, flags=1, data=
09/03 12:39:58 yS1  check for lockfiles
09/03 12:39:58 yS1   checklock: stat failed, no file
09/03 12:39:58 yS1  locking the line
09/03 12:39:58 yS1   makelock(ttyS1) called
09/03 12:39:58 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
09/03 12:39:58 yS1   lock made
09/03 12:39:58 yS1   tio_get_rs232_lines: status: RTS CTS DSR DTR
09/03 12:39:58 yS1  lowering DTR to reset Modem
09/03 12:39:59 yS1   tss: set speed to 38400 (017)
09/03 12:39:59 yS1   tio_set_flow_control( HARD )
09/03 12:39:59 yS1  WARNING: obsolete setserial spd_hi/spd_vhi used, 38400 is not real port speed
09/03 12:39:59 yS1   waiting for line to clear (VTIME), read: 
09/03 12:39:59 yS1  send: \d\d\d+++\d\d\dAT&FS2=255[0d]
09/03 12:40:02 yS1  waiting for ``OK''
09/03 12:40:02 yS1   got: AT&FS2=255[0d]
09/03 12:40:02 yS1    CND: AT&FS2=255[0d][0a]OK ** found **
09/03 12:40:02 yS1  send: ATN3S0=0S13.2=1[0d]
09/03 12:40:02 yS1  waiting for ``OK''
09/03 12:40:02 yS1   got: [0d]
09/03 12:40:02 yS1    CND: OK[0a]ATN3S0=0S13.2=1[0d]
09/03 12:40:02 yS1    CND: ATN3S0=0S13.2=1[0d][0a]OK ** found **
09/03 12:40:02 yS1  send: AT[0d]
09/03 12:40:02 yS1  do_stat: expect 'OK' ** found **
09/03 12:40:02 yS1  send: ATI2[0d]
09/03 12:40:02 yS1  do_stat: expect 'OK' ** found **
09/03 12:40:02 yS1  mdm_send: 'AT+FCLASS=2'
09/03 12:40:02 yS1    got:[0a]AT+FCLASS=2[0d]
09/03 12:40:02 yS1   mdm_command: string 'AT+FCLASS=2'
09/03 12:40:02 yS1    got:[0d][0a]OK[0d]
09/03 12:40:02 yS1   mdm_command: string 'OK' -> OK
09/03 12:40:02 yS1  mdm_send: 'AT+FCLASS=0'
09/03 12:40:02 yS1    got:[0a]AT+FCLASS=0[0d]
09/03 12:40:02 yS1   mdm_command: string 'AT+FCLASS=0'
09/03 12:40:02 yS1    got:[0d][0a]OK[0d]
09/03 12:40:02 yS1   mdm_command: string 'OK' -> OK
09/03 12:40:03 yS1  mdm_send: 'AT+FAA=1;+FCR=1'
09/03 12:40:03 yS1    got:[0a]AT+FAA=1;+FCR=1[0d]
09/03 12:40:03 yS1   mdm_command: string 'AT+FAA=1;+FCR=1'
09/03 12:40:03 yS1    got:[0d][0a]OK[0d]
09/03 12:40:03 yS1   mdm_command: string 'OK' -> OK
09/03 12:40:03 yS1  mdm_send: 'AT+FBOR=0'
09/03 12:40:03 yS1    got:[0a]AT+FBOR=0[0d]
09/03 12:40:03 yS1   mdm_command: string 'AT+FBOR=0'
09/03 12:40:03 yS1    got:[0d][0a]OK[0d]
09/03 12:40:03 yS1   mdm_command: string 'OK' -> OK
09/03 12:40:03 yS1  mdm_send: 'AT+FLID="++49-7531-95137"'
09/03 12:40:03 yS1    got:[0a]AT+FLID="++49-7531-95137"[0d]
09/03 12:40:03 yS1   mdm_command: string 'AT+FLID="++49-7531-95137"'
09/03 12:40:03 yS1    got:[0d][0a]OK[0d]
09/03 12:40:03 yS1   mdm_command: string 'OK' -> OK
09/03 12:40:03 yS1  mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
09/03 12:40:03 yS1    got:[0a]AT+FDCC=1,5,0,2,0,0,0,0[0d]
09/03 12:40:03 yS1   mdm_command: string 'AT+FDCC=1,5,0,2,0,0,0,0'
09/03 12:40:03 yS1    got:[0d][0a]OK[0d]
09/03 12:40:03 yS1   mdm_command: string 'OK' -> OK
09/03 12:40:03 yS1   tss: set speed to 38400 (017)
09/03 12:40:03 yS1   tio_set_flow_control( HARD )
09/03 12:40:03 yS1  detecting voice modem type
09/03 12:40:03 yS1    vgetty: ATE1
09/03 12:40:03 yS1   voice command: '' -> 'OK|ATE1'
09/03 12:40:03 yS1    serial port: ATE1
09/03 12:40:03 yS1    serial port: OK
09/03 12:40:03 yS1   voice command: 'ATI' -> ''
09/03 12:40:03 yS1    vgetty: ATI
09/03 12:40:03 yS1    serial port: ATI
09/03 12:40:03 yS1    serial port: 28642
09/03 12:40:03 yS1    ZyXEL 2864: OK
09/03 12:40:03 yS1  ZyXEL 2864 detected
09/03 12:40:03 yS1   vgetty: entering voice mode
09/03 12:40:03 yS1   vgetty: Installing signal handlers
09/03 12:40:03 yS1   voice command: 'AT+FCLASS?' -> ''
09/03 12:40:03 yS1    vgetty: AT+FCLASS?
09/03 12:40:03 yS1    ZyXEL 2864: AT+FCLASS?
09/03 12:40:04 yS1    ZyXEL 2864: 0
09/03 12:40:04 yS1   voice command: '' -> 'OK'
09/03 12:40:04 yS1    ZyXEL 2864: OK
09/03 12:40:04 yS1   voice command: 'AT+FCLASS=8' -> 'OK'
09/03 12:40:04 yS1    vgetty: AT+FCLASS=8
09/03 12:40:04 yS1    ZyXEL 2864: AT+FCLASS=8
09/03 12:40:04 yS1    ZyXEL 2864: OK
09/03 12:40:04 yS1   voice command: 'AT' -> 'OK'
09/03 12:40:04 yS1    vgetty: AT
09/03 12:40:04 yS1    ZyXEL 2864: AT
09/03 12:40:04 yS1    ZyXEL 2864: OK
09/03 12:40:04 yS1    vgetty: queued event RESET_WATCHDOG at position 0000
09/03 12:40:04 yS1  initializing ZyXEL 2864 voice modem
09/03 12:40:04 yS1   voice command: 'ATS48.5=1' -> 'OK'
09/03 12:40:04 yS1    vgetty: ATS48.5=1
09/03 12:40:04 yS1    vgetty: unqueued event RESET_WATCHDOG at position 0000
09/03 12:40:04 yS1    vgetty: voice_handle_event got event RESET_WATCHDOG with data <
09/03 12:40:04 yS1    ZyXEL 2864: ATS48.5=1
09/03 12:40:04 yS1    ZyXEL 2864: OK
09/03 12:40:04 yS1   voice command: 'ATS40.3=1 S40.4=1 S40.5=1 S40.6=1' -> 'OK'
09/03 12:40:04 yS1    vgetty: ATS40.3=1 S40.4=1 S40.5=1 S40.6=1
09/03 12:40:04 yS1    ZyXEL 2864: ATS40.3=1 S40.4=1 S40.5=1 S40.6=1
09/03 12:40:04 yS1    ZyXEL 2864: OK
09/03 12:40:04 yS1   voice command: 'AT+VIT=100' -> 'OK'
09/03 12:40:04 yS1    vgetty: AT+VIT=100
09/03 12:40:04 yS1    ZyXEL 2864: AT+VIT=100
09/03 12:40:04 yS1    ZyXEL 2864: OK
09/03 12:40:04 yS1   voice command: 'AT+VDD=6,6' -> 'OK'
09/03 12:40:04 yS1    vgetty: AT+VDD=6,6
09/03 12:40:04 yS1    ZyXEL 2864: AT+VDD=6,6
09/03 12:40:04 yS1    ZyXEL 2864: OK
09/03 12:40:04 yS1   voice command: 'AT+VSD=12,70' -> 'OK'
09/03 12:40:05 yS1    vgetty: AT+VSD=12,70
09/03 12:40:05 yS1    ZyXEL 2864: AT+VSD=12,70
09/03 12:40:05 yS1    ZyXEL 2864: OK
09/03 12:40:05 yS1   voice command: 'AT+VGT=128' -> 'OK'
09/03 12:40:05 yS1    vgetty: AT+VGT=128
09/03 12:40:05 yS1    ZyXEL 2864: AT+VGT=128
09/03 12:40:05 yS1    ZyXEL 2864: OK
09/03 12:40:05 yS1   voice command: 'AT+VGR=128' -> 'OK'
09/03 12:40:05 yS1    vgetty: AT+VGR=128
09/03 12:40:05 yS1    ZyXEL 2864: AT+VGR=128
09/03 12:40:05 yS1    ZyXEL 2864: OK
09/03 12:40:05 yS1   vgetty: leaving voice mode
09/03 12:40:05 yS1   voice command: 'AT+FCLASS=0' -> 'OK'
09/03 12:40:05 yS1    vgetty: AT+FCLASS=0
09/03 12:40:05 yS1    ZyXEL 2864: AT+FCLASS=0
09/03 12:40:05 yS1    ZyXEL 2864: OK
09/03 12:40:05 yS1   voice command: 'AT' -> 'OK'
09/03 12:40:05 yS1    vgetty: AT
09/03 12:40:05 yS1    ZyXEL 2864: AT
09/03 12:40:05 yS1    ZyXEL 2864: OK
09/03 12:40:05 yS1   vgetty: Restoring signal handlers
09/03 12:40:05 yS1    vgetty: checking for message flag file /var/spool/voice/.flag
09/03 12:40:05 yS1   voice command: 'ATS0=0' -> 'OK'
09/03 12:40:05 yS1    vgetty: ATS0=0
09/03 12:40:05 yS1    ZyXEL 2864: ATS0=0
09/03 12:40:05 yS1    ZyXEL 2864: OK
09/03 12:40:05 yS1   waiting for line to clear (VTIME), read: 
09/03 12:40:06 yS1   removing lock file
09/03 12:40:06 yS1  waiting...

--- end of logg

--
my dtmf.sh

#! /usr/bin/vm shell

#
# This is the dtmf script. It is called by vgetty when a dtmf code was
# send by the user.
#
# $1 - received DTMF code
# $2 - name of the recorded voice file
#
# $Id: dtmf.sh,v 1.3 1998/03/25 23:06:11 marc Exp $
#

VOICE_DIR=/var/spool/voice

CODE=`cat $VOICE_DIR/.code`
FLAG=$VOICE_DIR/.flag
TIMESTAMP=$VOICE_DIR/.timestamp

MSG_DIR=$VOICE_DIR/messages
GET_CODE=$MSG_DIR/get-code.rmd
INCORRECT=$MSG_DIR/incorrect.rmd
GOODBYE=$MSG_DIR/goodbye.rmd
NO_NEW_MESSAGES=$MSG_DIR/no_new_messages.rmd

MAXTRIES=3

#
# Define the function to receive an answer from the voice library
#

function receive
     {
     read -r INPUT <&$VOICE_INPUT;
     echo "$INPUT";
     }

#
# Define the function to send a command to the voice library
#

function send
     {
     echo $1 >&$VOICE_OUTPUT;
     kill -PIPE $VOICE_PID
     }

#
# Define the function send a beep
#

function beep
     {
     send "BEEP $1 $2"
     ANSWER=`receive`

     if [ "$ANSWER" != "BEEPING" ]; then
          logger -t "dtmf.sh[$$]" "Could not start beeping"
          kill -KILL $$
     fi

     ANSWER=`receive`

     if [ "$ANSWER" != "READY" ]; then
          logger -t "dtmf.sh[$$]" "Something went wrong on beeping"
          kill -KILL $$
     fi

     }

#
# Define the function to play a file
#

function play
     {
     send "PLAY $1"
     ANSWER=`receive`

     if [ "$ANSWER" != "PLAYING" ]; then
          logger -t "dtmf.sh[$$]" "Could not start playing"
          kill -KILL $$
     fi

     ANSWER=`receive`

     if [ "$ANSWER" != "READY" ]; then
          logger -t "dtmf.sh[$$]" "Something went wrong on playing"
          kill -KILL $$
     fi

     }

#
# Define the function to play the new messages
#

function messages
     {

     if [ ! -f $TIMESTAMP ]; then
          MSGS=`find $VOICE_DIR/incoming/ -type f -name 'v*.rmd' -print`
     else
          MSGS=`find $VOICE_DIR/incoming/ -type f -name 'v*.rmd' -newer $TIMESTAMP -print`

          if [ -z "$MSGS" ]; then
               BASENAME=`basename $TIMESTAMP`
               NEWSTAMP=`find $VOICE_DIR -name $BASENAME -cmin -10 -print`

               if [ "$NEWSTAMP" = "$TIMESTAMP" ]; then
                    MSGS=`find $VOICE_DIR/incoming/ -type f -name 'v*.rmd' -print`
               fi

          fi

     fi

     touch $TIMESTAMP-n

     if [ -x $VOICE_DIR/speakdate.sh ]; then
          TIME=yes
     else
          TIME=no
     fi

     TMP=/tmp/time.rmd.$$
     LOCK=/tmp/time-lock.$$

     for i in $MSGS
     do

          #
          # The sample speed, modem type and compression is hardcoded
          # here for the moment. Will be automatically set to correct
          # values in a later version.
          #
          # For ISDN4Linux use:
          # ...speakdate.sh $i 9600 ISDN4Linux 4 >$TMP ;\
          # For Rockwell modems use:
          # ...speakdate.sh $i 7200 Rockwell 4 >$TMP ;\
          # For the ZyXEL Elite 2864 use:
          # ...speakdate.sh $i 9600 ZyXEL_2864 4 >$TMP ;\
          #

          if [ $TIME = yes ]; then
               (touch $LOCK ;\
               $VOICE_DIR/speakdate.sh $i 8000 ZyXEL_2864 4 >$TMP ;\
               rm $LOCK) &G
          fi


          if [ $TIME = yes ]; then

               while [ -f $LOCK ]
               do
                    sleep 1
               done

               play $TMP
               rm $TMP
          fi
          beep 1320 100
          play $i
          beep 1320 100

     done

     if [ -z "$MSGS" ]; then
          play "$NO_NEW_MESSAGES"
     fi

     beep 880 1000
     rm -f $FLAG $TIMESTAMP
     mv $TIMESTAMP-n $TIMESTAMP
     #
     # I'm using the scroll lock LED on my keyboard to signal new calls.
     # This program resets this LED. You probably want to disable it.
     #
     scrolloff
     }

#
# Define the function to read one dtmf code string
#

function getcode
     {
     RECEIVED=""
     send "ENABLE EVENTS"

     ANSWER=`receive`

     if [ "$ANSWER" != "READY" ]; then
          logger -t "dtmf.sh[$$]" "Could not enable events"
          kill -KILL $$
     fi

     send "WAIT 5"

     ANSWER=`receive`

     if [ "$ANSWER" != "WAITING" ]; then
          logger -t "dtmf.sh[$$]" "Could not start waiting"
          kill -KILL $$
     fi

#     ANSWER=`receive`

     while [ "$ANSWER" != "READY" ]
     do
          ANSWER=`receive`

          if [ "$ANSWER" = "RECEIVED_DTMF" ]; then
               ANSWER=`receive`

               if [ "$ANSWER" = "*" ]; then
                    RECEIVED=""
               else

                    case $ANSWER in
                    "#")
                         send "STOP"
                                  ;;
                    0|1|2|3|4|5|6|7|8|9)
                         RECEIVED=$RECEIVED$ANSWER
                                  ;;
                    *)
                         logger -t "dtmf.sh[$$]" "Ignoring DTMF $ANSWER"
                                  ;;
                    esac

               fi

          else

               if [ "$ANSWER" = "SILENCE_DETECTED" ]; then
                    send "STOP"
               else

                    if [ "$ANSWER" != "READY" ]; then
                         logger -t "dtmf.sh[$$]" "Ignoring $ANSWER"
                    fi

               fi

          fi

     done

     send "DISABLE EVENTS"

     ANSWER=`receive`

     if [ "$ANSWER" != "READY" ]; then
          logger -t "dtmf.sh[$$]" "Could not disable events"
          kill -KILL $$
     fi

     echo "$RECEIVED"
     }

#
# Let's see if the voice library is talking to us
#

ANSWER=`receive`

if [ "$ANSWER" != "HELLO SHELL" ]; then
     logger -t "dtmf.sh[$$]" "Voice library not answering"
     kill -KILL $$
fi

#
# Let's answer the message
#

send "HELLO VOICE PROGRAM"

#
# Let's see if it worked
#

ANSWER=`receive`

if [ "$ANSWER" != "READY" ]; then
     logger -t "dtmf.sh[$$]" "Initialization failed"
     kill -KILL $$
fi

#
# Let's check the code
#

TRIES=1
DTMF=$1

while [ $TRIES -le $MAXTRIES ]
do

     if [ "$DTMF" = "$CODE" ]; then

          if [ -f $2 ]; then
               rm -f $2
          fi

          messages
          break
     else
          logger -t "dtmf.sh[$$]" "Incorrect DTMF code on try $TRIES"
          beep 1320 100
          play "$INCORRECT"
     fi

     if [ $TRIES -lt $MAXTRIES ]; then
          play "$GET_CODE"
          beep 1320 100
          DTMF=`getcode`
     else
          play "$GOODBYE"
     fi

     TRIES=`expr $TRIES + 1`
done
#
# Let's say goodbye
#

send "GOODBYE"

#
# Let's see if the voice library got it
#

ANSWER=`receive`

if [ "$ANSWER" != "GOODBYE SHELL" ]; then
     logger -t "dtmf.sh[$$]" "Could not say goodbye to voice library"
     kill -KILL $$
fi

exit 0
--- end of dtmf.sh


> PS: did you try using vgetty with a voice_script instead of vm ?

I think so!
 
I hope anyone can help.
---
Heute ist nicht alle Tage, ich komme wieder, keine Frage!!!

   Joerg