ZyXEL Elite 2864ID problems sending fax from voice mode

"Robert J. Brown" (rj@eli.elilabs.com)
Thu, 25 Jun 1998 22:41:01 +0200


>>>>> "Gert" == Gert Doering <gert@greenie.muc.de> writes:

    Gert> Hmmm.  Some memory reappears.  I think there was some
    Gert> discussion on the ZyXEL Alpha-Testers mailing list about
    Gert> *exactly* that problem half a year ago (or so) -- some voice
    Gert> application not being able to go to fax mode without hanging
    Gert> up in between.  Commercial windows stuff, but the same basic
    Gert> problem.

    Gert> Do you remember as well?

No, I don't, but I am experiencing the same problem.  I never noticed
it before, but I have been doing a lot of faxing lately, and sometimes 
the modem says it is not a 2/2.0 faxmodem, so I power cycle it, and it 
comes to its senses.  What I see is that after a voicemail is
recorded, I cannot send faxes unless I power-cycle the modem.  :-(

    Gert> What was the solution?

I am currently using the pragmatic power-cycle work around, but I
would like to fix this.  I am using a Zyxel Omni 288S modem for
voice/fax/data, together with caller-id and distictive ring, having
ring-1 answer voice, ring-2 answer fax/data, and ring-3 not answer at
all -- so people do not have to pay a long distance charge if they
only want to speak to me, and not leave a voicemail message.  

The voicemail has problems also, but kind of works.  It will usually
take a message, but often fails to report the caller id at all, and
the message has a lot of silence at the beginning and end.  It also
usually fails to send me email when a voice message is recorded, but
ocassionally (rarely) it does.

Data seems to work ok.

Here is the version of firmware I am running:

OK                                                                              
ati0                                                                            
288                                                                             
                                                                                
OK                                                                              
ati1                                                                            
41343                                                                           
                                                                                
O288S  V 1.19                                                                   
                                                                                
OK                                                                              


Here are the current settings (minicom may have messed with some of
these): 

OK
at&v

Current   Settings............
 B0   E1   L1   M0   N3   Q0   V1   X4  
&B1  &C1  &D2  &G0  &H3  &J0  &K4  &L0  &M0  &N0  &P0  &R1  &S0  &X0  &Y1  
*B0  *C0  *D0  *E0  *F0  *G0  *I0  *L0  *M0  *P11 *Q2  *S0  
S000=000 S001=000 S002=255 S003=013 S004=010 S005=008 S006=003 S007=045 
S008=002 S009=006 S010=007 S011=070 S012=000 S013=004 S014=002 S015=130 
S016=000 S017=022 S018=000 S019=000 S020=001 S021=176 S022=000 S023=097 
S024=019 S025=000 S026=000 S027=156 S028=068 S029=000 S030=000 S031=017 
S032=019 S033=000 S034=030 S035=032 S036=000 S037=000 S038=000 S039=032 
S040=124 S041=000 S042=000 S043=008 S044=000 S045=100 S046=028 S047=064 
S048=032 S049=006 S050=000 S051=000 S052=000 S053=000 S054=000 S055=000 
S056=000 S057=016 S058=002 S059=000 S060=002 S061=000 S062=000 S063=000 
S064=000 S065=000 S066=000 S067=000 S068=000 S069=000 S070=000 S071=064 
S072=000 S073=009 S074=001 S075=000 S076=000 S077=000 S078=000 S079=000 
S080=000 S081=000 S082=000 S083=000 S084=000 S085=000 S086=000 S087=000 
S088=000 S089=000 S090=000 S091=000 S092=000 S093=000 S094=000 S095=000 
S096=000 S097=000 S098=000 S099=000 S100=000 S101=000 S102=000 S103=000 
S104=000 S105=000 S106=000 S107=000 S108=000 S109=000 S110=000 S111=000 
S112=000 S113=000 S114=000 S115=000 S116=000 S117=000 S118=000 S119=000 
S120=000 S121=000 S122=000 S123=000 S124=000 S125=000 S126=000 S127=000 

OK


Here is the voice.conf file with comments and blank lines deleted:

part generic
voice_log_level 5
voice_dir /var/spool/voice
message_flag_file .flag
receive_dir incoming
message_dir messages
message_list Index
backup_message standard.rmd
port_speed 115200
voice_shell /bin/sh
port_timeout 10
dial_timeout 90
command_delay 150
dtmf_len 30
dtmf_threshold 40
dtmf_wait 7
ignore_fax_dle false
raw_data false
rec_compression 4
rec_speed 9600
rec_silence_len 70
rec_silence_threshold 40
rec_remove_silence true
rec_max_len 300
rec_min_len 0
do_hard_flow true
beep_frequency 933
beep_length 150
max_tries 3
retry_delay 5
watchdog_timeout 90
receive_gain -1
transmit_gain -1
enable_command_echo true
program vgetty
speaker_answer_volume 100
rings 2
force_autodetect false
rec_always_keep false
button_program 
call_program
dtmf_program dtmf.sh
message_program /home/rj/scripts/voicemail_rcvd
do_message_light false
program vm
voice_devices ttyS1
dialout_timeout 90
speaker_play_volume 100
program pvf
ring_type ring
rings 3
answer_mode voice/fax
ring_type ring2
rings 2
answer_mode data
ring_type ring4
rings 2
answer_mode /usr/local/etc/mgetty+sendfax/answer/ring4
answer_mode fax


Here is the script that is supposed to send me mail when a voice mail
is recorded:

    #   voicemail_rcvd -- notify rj that voice mail came in

    { echo "You got voice mail." 
      ls -la $* } | mail rj


Here is an extract of the log file for a voice call, with suspicious
parts flagged by '!!!!!!!!!!!!!!!!':

06/24 08:26:39 yS1  checking if modem is still alive
06/24 08:26:39 yS1   makelock(ttyS1) called
06/24 08:26:39 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
06/24 08:26:39 yS1   lock made
06/24 08:26:39 yS1  mdm_send: 'AT'
06/24 08:26:39 yS1   mdm_command: string 'AT'
06/24 08:26:39 yS1   mdm_command: string 'OK' -> OK
06/24 08:26:39 yS1   waiting for line to clear (VTIME), read: 
06/24 08:26:39 yS1   removing lock file
06/24 08:26:39 yS1  waiting...
06/24 08:35:21 yS1   checking lockfiles, locking the line
06/24 08:35:21 yS1   makelock(ttyS1) called
06/24 08:35:21 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
06/24 08:35:21 yS1   lock made
06/24 08:35:21 yS1  waiting for ``RING_''
06/24 08:35:21 yS1   got: TIME: 06-24 08:35 [0d][0a]CALLER NUMBER: 6305058771[0d][0a]CALLER NAME: ALPHA DIV TAD R[0d][0a][0d][0a]RING[0d] ** found **
06/24 08:35:26 yS1  waiting for ``RING_''
06/24 08:35:26 yS1   got: [0a][0d][0a]RING[0d] ** found **
06/24 08:35:32 yS1  reading ring_type ring configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf
06/24 08:35:32 yS1   reading /usr/local/etc/mgetty+sendfax/voice.conf...
06/24 08:35:32 yS1   conf lib: read: 'part generic'
06/24 08:35:32 yS1   found CT_KEYWORD part generic
06/24 08:35:32 yS1   conf lib: read: 'voice_log_level 5'
06/24 08:35:32 yS1   conf lib: read: 'voice_dir /var/spool/voice'
06/24 08:35:32 yS1   conf lib: read: 'message_flag_file .flag'
06/24 08:35:32 yS1   conf lib: read: 'receive_dir incoming'
06/24 08:35:32 yS1   conf lib: read: 'message_dir messages'
06/24 08:35:32 yS1   conf lib: read: 'message_list Index'
06/24 08:35:32 yS1   conf lib: read: 'backup_message standard.rmd'
06/24 08:35:32 yS1   conf lib: read: 'port_speed 115200'
06/24 08:35:32 yS1   conf lib: read: 'voice_shell /bin/sh'
06/24 08:35:32 yS1   conf lib: read: 'port_timeout 10'
06/24 08:35:32 yS1   conf lib: read: 'dial_timeout 90'
06/24 08:35:32 yS1   conf lib: read: 'command_delay 150'
06/24 08:35:32 yS1   conf lib: read: 'dtmf_len 30'
06/24 08:35:32 yS1   conf lib: read: 'dtmf_threshold 40'
06/24 08:35:32 yS1   conf lib: read: 'dtmf_wait 7'
06/24 08:35:32 yS1   conf lib: read: 'ignore_fax_dle false'
06/24 08:35:32 yS1   conf lib: read: 'raw_data false'
06/24 08:35:32 yS1   conf lib: read: 'rec_compression 4'
06/24 08:35:32 yS1   conf lib: read: 'rec_speed 9600'
06/24 08:35:32 yS1   conf lib: read: 'rec_silence_len 70'
06/24 08:35:32 yS1   conf lib: read: 'rec_silence_threshold 40'
06/24 08:35:32 yS1   conf lib: read: 'rec_remove_silence true'
06/24 08:35:32 yS1   conf lib: read: 'rec_max_len 300'
06/24 08:35:32 yS1   conf lib: read: 'rec_min_len 0'
06/24 08:35:32 yS1   conf lib: read: 'do_hard_flow true'
06/24 08:35:32 yS1   conf lib: read: 'beep_frequency 933'
06/24 08:35:32 yS1   conf lib: read: 'beep_length 150'
06/24 08:35:32 yS1   conf lib: read: 'max_tries 3'
06/24 08:35:32 yS1   conf lib: read: 'retry_delay 5'
06/24 08:35:32 yS1   conf lib: read: 'watchdog_timeout 90'
06/24 08:35:32 yS1   conf lib: read: 'receive_gain -1'
06/24 08:35:32 yS1   conf lib: read: 'transmit_gain -1'
06/24 08:35:32 yS1   conf lib: read: 'enable_command_echo true'
06/24 08:35:32 yS1   conf lib: read: 'program vgetty'
06/24 08:35:32 yS1   conf lib: read: 'speaker_answer_volume 100'
06/24 08:35:32 yS1   conf lib: read: 'rings 2'
06/24 08:35:32 yS1   conf lib: read: 'force_autodetect false'
06/24 08:35:32 yS1   conf lib: read: 'rec_always_keep false'
06/24 08:35:32 yS1   conf lib: read: 'button_program '
06/24 08:35:32 yS1   conf lib: read: 'call_program '
06/24 08:35:32 yS1   conf lib: read: 'dtmf_program dtmf.sh'
06/24 08:35:32 yS1   conf lib: read: 'message_program /home/rj/scripts/voicemail_rcvd'
06/24 08:35:32 yS1   conf lib: read: 'do_message_light false'
06/24 08:35:32 yS1   conf lib: read: 'program vm'
06/24 08:35:32 yS1   conf lib: read: 'voice_devices ttyS1'
06/24 08:35:32 yS1   conf lib: read: 'dialout_timeout 90'
06/24 08:35:32 yS1   conf lib: read: 'speaker_play_volume 100'
06/24 08:35:32 yS1   conf lib: read: 'program pvf'
06/24 08:35:32 yS1   conf lib: read: 'ring_type ring'
06/24 08:35:32 yS1   section: ring_type ring, **found**
06/24 08:35:32 yS1   conf lib: read: 'rings 3'
06/24 08:35:32 yS1   conf lib: read: 'answer_mode voice/fax'
06/24 08:35:32 yS1   conf lib: read: 'ring_type ring2'
06/24 08:35:32 yS1   section: ring_type ring2, ignore
06/24 08:35:32 yS1   conf lib: read: 'rings 2'
06/24 08:35:32 yS1   conf lib: read: 'answer_mode data'
06/24 08:35:32 yS1   conf lib: read: 'ring_type ring4'
06/24 08:35:32 yS1   section: ring_type ring4, ignore
06/24 08:35:32 yS1   conf lib: read: 'rings 2'
06/24 08:35:32 yS1   conf lib: read: 'answer_mode /usr/local/etc/mgetty+sendfax/answer/ring4'
06/24 08:35:32 yS1   conf lib: read: 'answer_mode fax'
06/24 08:35:32 yS1   key: 'part', type=6, flags=4, data=(ignored)
06/24 08:35:32 yS1   key: 'program', type=6, flags=4, data=(ignored)
06/24 08:35:32 yS1   key: 'port', type=6, flags=4, data=(ignored)
06/24 08:35:32 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
06/24 08:35:32 yS1   key: 'voice_log_level', type=0, flags=3, data=5
06/24 08:35:32 yS1   key: 'voice_devices', type=1, flags=0, data=(empty)
06/24 08:35:32 yS1   key: 'port_speed', type=0, flags=3, data=115200
06/24 08:35:32 yS1   key: 'port_timeout', type=0, flags=3, data=10
06/24 08:35:32 yS1   key: 'dtmf_len', type=0, flags=3, data=30
06/24 08:35:32 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
06/24 08:35:32 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
06/24 08:35:32 yS1   key: 'rec_compression', type=0, flags=3, data=4
06/24 08:35:32 yS1   key: 'rec_speed', type=0, flags=3, data=9600
06/24 08:35:32 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
06/24 08:35:32 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
06/24 08:35:32 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
06/24 08:35:32 yS1   key: 'rec_max_len', type=0, flags=3, data=300
06/24 08:35:32 yS1   key: 'receive_gain', type=0, flags=3, data=50
06/24 08:35:32 yS1   key: 'transmit_gain', type=0, flags=3, data=50
06/24 08:35:32 yS1   key: 'rings', type=1, flags=3, data=3
06/24 08:35:32 yS1   key: 'answer_mode', type=1, flags=3, data=voice/fax
06/24 08:35:32 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
06/24 08:35:32 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
06/24 08:35:32 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
06/24 08:35:32 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
06/24 08:35:32 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
06/24 08:35:32 yS1   key: 'message_dir', type=1, flags=3, data=messages
06/24 08:35:32 yS1   key: 'message_list', type=1, flags=3, data=Index
06/24 08:35:32 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
06/24 08:35:32 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
06/24 08:35:32 yS1   key: 'beep_frequency', type=0, flags=3, data=933
06/24 08:35:32 yS1   key: 'beep_length', type=0, flags=3, data=150
06/24 08:35:32 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
06/24 08:35:32 yS1   key: 'max_tries', type=0, flags=3, data=3
06/24 08:35:32 yS1   key: 'retry_delay', type=0, flags=3, data=5
06/24 08:35:32 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
06/24 08:35:32 yS1   key: 'button_program', type=1, flags=3, data=
06/24 08:35:32 yS1   key: 'call_program', type=1, flags=3, data=
06/24 08:35:32 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
06/24 08:35:32 yS1   key: 'message_program', type=1, flags=3, data=/home/rj/scripts/voicemail_rcvd
06/24 08:35:32 yS1   key: 'do_message_light', type=3, flags=3, data=FALSE
06/24 08:35:32 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
06/24 08:35:32 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
06/24 08:35:32 yS1   key: 'watchdog_timeout', type=0, flags=3, data=90
06/24 08:35:32 yS1   key: 'rec_min_len', type=0, flags=3, data=0
06/24 08:35:32 yS1   key: 'command_delay', type=0, flags=3, data=150
06/24 08:35:32 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
06/24 08:35:32 yS1   key: 'dial_timeout', type=0, flags=3, data=90
06/24 08:35:32 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
06/24 08:35:32 yS1   vgetty: entering voice mode
06/24 08:35:32 yS1   vgetty: Installing signal handlers
06/24 08:35:33 yS1   voice command: 'AT+FCLASS?' -> ''
06/24 08:35:33 yS1   voice command: '' -> 'OK'
06/24 08:35:33 yS1   voice command: 'AT+FCLASS=8' -> 'OK'
06/24 08:35:33 yS1   voice command: 'AT+VLS=2' -> 'OK|CONNECT'
06/24 08:35:33 yS1  playing voice file /var/spool/voice/messages/standard.rmd
06/24 08:35:33 yS1   vgetty: raw modem data header found
06/24 08:35:33 yS1   vgetty: modem type ZyXEL 2864 found
06/24 08:35:33 yS1   vgetty: compression method 0x0004, speed 9600, bits 4
06/24 08:35:33 yS1   voice command: 'AT+VSM=4,9600' -> 'OK'
06/24 08:35:33 yS1   voice command: 'AT+FLO=2' -> 'OK'
06/24 08:35:34 yS1   tio_set_flow_control( HARD XON_OUT )
06/24 08:35:34 yS1   voice command: 'AT+VTX' -> 'CONNECT'
06/24 08:35:34 yS1  vgetty: Buffer underrun
06/24 08:35:46 yS1   voice command: '' -> 'OK|VCON'
06/24 08:35:47 yS1   voice command: 'AT' -> 'OK'
06/24 08:35:47 yS1   voice command: 'AT+VTS=[933,0,150]' -> ''
06/24 08:35:48 yS1   voice command: '' -> 'OK'
06/24 08:35:49 yS1  recording voice file /var/spool/voice/incoming/va11700.rmd
06/24 08:35:49 yS1   voice command: 'AT+VSM=4,9600' -> 'OK'
06/24 08:35:49 yS1   voice command: 'AT+FLO=2' -> 'OK'
06/24 08:35:49 yS1   tio_set_flow_control( HARD XON_IN )
06/24 08:35:49 yS1   voice command: 'AT+VRX' -> 'CONNECT'
06/24 08:36:10 yS1   voice command: 'AT' -> 'OK'
06/24 08:36:10 yS1   voice command: 'AT+VTS=[933,0,150]' -> ''
06/24 08:36:12 yS1   voice command: '' -> 'OK'
06/24 08:36:12 yS1   voice command: 'AT+VLS=0' -> 'OK'
06/24 08:36:12 yS1   vgetty: leaving voice mode
06/24 08:36:12 yS1   voice command: 'AT+FCLASS=0' -> 'OK'
06/24 08:36:13 yS1   vgetty: Restoring signal handlers
06/24 08:36:13 yS1  closing voice modem device
06/24 08:36:13 yS1   removing lock file
06/24 08:36:13 ##### message keep, length=00:00:21, name='ALPHA DIV TAD R', caller=6305058771, dev=ttyS1, pid=11700

06/24 08:36:13 yS1   executing message program, dev=ttyS1, pid=11700
06/24 08:36:13 yS1  vgetty: Executing shell script /home/rj/scripts/voicemail_rcvd with shell /bin/sh
06/24 08:36:13 yS1   vgetty(0): HELLO SHELL
06/24 08:36:13 yS1   vgetty: shell exited normally with status 0x0000
--
06/24 08:36:13 yS1  vgetty: experimental test release 0.7.3 / 10Aug97
06/24 08:36:13 yS1  mgetty: experimental test release 1.1.9-Aug17
06/24 08:36:13 yS1  reading generic configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf
06/24 08:36:13 yS1  reading program vgetty configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf


06/24 08:36:13 yS1  something foul in config line: 'speaker_answer_volume 100'
06/24 08:36:13 yS1      (keyword 'speaker_answer_volume' not found)

	!!!!!!!!!!!!!!!! Is this a problem?  What is the proper command to do this?

06/24 08:36:13 yS1  reading port ttyS1 configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf
06/24 08:36:13 yS1   reading /usr/local/etc/mgetty+sendfax/voice.conf...
06/24 08:36:13 yS1   conf lib: read: 'part generic'
06/24 08:36:13 yS1   found CT_KEYWORD part generic
06/24 08:36:13 yS1   conf lib: read: 'voice_log_level 5'
06/24 08:36:13 yS1   conf lib: read: 'voice_dir /var/spool/voice'
06/24 08:36:13 yS1   conf lib: read: 'message_flag_file .flag'
06/24 08:36:13 yS1   conf lib: read: 'receive_dir incoming'
06/24 08:36:13 yS1   conf lib: read: 'message_dir messages'
06/24 08:36:13 yS1   conf lib: read: 'message_list Index'
06/24 08:36:13 yS1   conf lib: read: 'backup_message standard.rmd'
06/24 08:36:13 yS1   conf lib: read: 'port_speed 115200'
06/24 08:36:13 yS1   conf lib: read: 'voice_shell /bin/sh'
06/24 08:36:13 yS1   conf lib: read: 'port_timeout 10'
06/24 08:36:13 yS1   conf lib: read: 'dial_timeout 90'
06/24 08:36:13 yS1   conf lib: read: 'command_delay 150'
06/24 08:36:13 yS1   conf lib: read: 'dtmf_len 30'
06/24 08:36:13 yS1   conf lib: read: 'dtmf_threshold 40'
06/24 08:36:13 yS1   conf lib: read: 'dtmf_wait 7'
06/24 08:36:13 yS1   conf lib: read: 'ignore_fax_dle false'
06/24 08:36:13 yS1   conf lib: read: 'raw_data false'
06/24 08:36:13 yS1   conf lib: read: 'rec_compression 4'
06/24 08:36:13 yS1   conf lib: read: 'rec_speed 9600'
06/24 08:36:13 yS1   conf lib: read: 'rec_silence_len 70'
06/24 08:36:13 yS1   conf lib: read: 'rec_silence_threshold 40'
06/24 08:36:13 yS1   conf lib: read: 'rec_remove_silence true'
06/24 08:36:13 yS1   conf lib: read: 'rec_max_len 300'
06/24 08:36:13 yS1   conf lib: read: 'rec_min_len 0'
06/24 08:36:13 yS1   conf lib: read: 'do_hard_flow true'
06/24 08:36:13 yS1   conf lib: read: 'beep_frequency 933'
06/24 08:36:13 yS1   conf lib: read: 'beep_length 150'
06/24 08:36:13 yS1   conf lib: read: 'max_tries 3'
06/24 08:36:13 yS1   conf lib: read: 'retry_delay 5'
06/24 08:36:13 yS1   conf lib: read: 'watchdog_timeout 90'
06/24 08:36:13 yS1   conf lib: read: 'receive_gain -1'
06/24 08:36:13 yS1   conf lib: read: 'transmit_gain -1'
06/24 08:36:13 yS1   conf lib: read: 'enable_command_echo true'
06/24 08:36:13 yS1   conf lib: read: 'program vgetty'
06/24 08:36:13 yS1   conf lib: read: 'speaker_answer_volume 100'
06/24 08:36:13 yS1   conf lib: read: 'rings 2'
06/24 08:36:13 yS1   conf lib: read: 'force_autodetect false'
06/24 08:36:13 yS1   conf lib: read: 'rec_always_keep false'
06/24 08:36:13 yS1   conf lib: read: 'button_program '
06/24 08:36:13 yS1   conf lib: read: 'call_program '
06/24 08:36:13 yS1   conf lib: read: 'dtmf_program dtmf.sh'
06/24 08:36:13 yS1   conf lib: read: 'message_program /home/rj/scripts/voicemail_rcvd'
06/24 08:36:13 yS1   conf lib: read: 'do_message_light false'
06/24 08:36:13 yS1   conf lib: read: 'program vm'
06/24 08:36:13 yS1   conf lib: read: 'voice_devices ttyS1'
06/24 08:36:13 yS1   conf lib: read: 'dialout_timeout 90'
06/24 08:36:13 yS1   conf lib: read: 'speaker_play_volume 100'
06/24 08:36:13 yS1   conf lib: read: 'program pvf'
06/24 08:36:13 yS1   conf lib: read: 'ring_type ring'
06/24 08:36:13 yS1   conf lib: read: 'rings 3'
06/24 08:36:13 yS1   conf lib: read: 'answer_mode voice/fax'
06/24 08:36:13 yS1   conf lib: read: 'ring_type ring2'
06/24 08:36:13 yS1   conf lib: read: 'rings 2'
06/24 08:36:13 yS1   conf lib: read: 'answer_mode data'
06/24 08:36:13 yS1   conf lib: read: 'ring_type ring4'
06/24 08:36:13 yS1   conf lib: read: 'rings 2'
06/24 08:36:13 yS1   conf lib: read: 'answer_mode /usr/local/etc/mgetty+sendfax/answer/ring4'
06/24 08:36:13 yS1   conf lib: read: 'answer_mode fax'
06/24 08:36:13 yS1   key: 'part', type=6, flags=4, data=(ignored)
06/24 08:36:13 yS1   key: 'program', type=6, flags=4, data=(ignored)
06/24 08:36:13 yS1   key: 'port', type=6, flags=4, data=(ignored)
06/24 08:36:13 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
06/24 08:36:13 yS1   key: 'voice_log_level', type=0, flags=3, data=5
06/24 08:36:13 yS1   key: 'voice_devices', type=1, flags=0, data=(empty)
06/24 08:36:13 yS1   key: 'port_speed', type=0, flags=3, data=115200
06/24 08:36:13 yS1   key: 'port_timeout', type=0, flags=3, data=10
06/24 08:36:13 yS1   key: 'dtmf_len', type=0, flags=3, data=30
06/24 08:36:13 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
06/24 08:36:13 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
06/24 08:36:13 yS1   key: 'rec_compression', type=0, flags=3, data=4
06/24 08:36:13 yS1   key: 'rec_speed', type=0, flags=3, data=9600
06/24 08:36:13 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
06/24 08:36:13 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
06/24 08:36:13 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
06/24 08:36:13 yS1   key: 'rec_max_len', type=0, flags=3, data=300
06/24 08:36:13 yS1   key: 'receive_gain', type=0, flags=3, data=-1
06/24 08:36:13 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
06/24 08:36:13 yS1   key: 'rings', type=1, flags=3, data=2
06/24 08:36:13 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
06/24 08:36:13 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
06/24 08:36:13 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
06/24 08:36:13 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
06/24 08:36:13 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
06/24 08:36:13 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
06/24 08:36:13 yS1   key: 'message_dir', type=1, flags=3, data=messages
06/24 08:36:13 yS1   key: 'message_list', type=1, flags=3, data=Index
06/24 08:36:13 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
06/24 08:36:13 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
06/24 08:36:13 yS1   key: 'beep_frequency', type=0, flags=3, data=933
06/24 08:36:13 yS1   key: 'beep_length', type=0, flags=3, data=150
06/24 08:36:13 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
06/24 08:36:13 yS1   key: 'max_tries', type=0, flags=3, data=3
06/24 08:36:13 yS1   key: 'retry_delay', type=0, flags=3, data=5
06/24 08:36:13 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
06/24 08:36:13 yS1   key: 'button_program', type=1, flags=3, data=
06/24 08:36:13 yS1   key: 'call_program', type=1, flags=3, data=
06/24 08:36:13 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
06/24 08:36:13 yS1   key: 'message_program', type=1, flags=3, data=/home/rj/scripts/voicemail_rcvd
06/24 08:36:13 yS1   key: 'do_message_light', type=3, flags=3, data=FALSE
06/24 08:36:13 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
06/24 08:36:13 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
06/24 08:36:13 yS1   key: 'watchdog_timeout', type=0, flags=3, data=90
06/24 08:36:13 yS1   key: 'rec_min_len', type=0, flags=3, data=0
06/24 08:36:13 yS1   key: 'command_delay', type=0, flags=3, data=150
06/24 08:36:13 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
06/24 08:36:13 yS1   key: 'dial_timeout', type=0, flags=3, data=90
06/24 08:36:13 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
06/24 08:36:13 yS1  check for lockfiles
06/24 08:36:13 yS1   checklock: stat failed, no file
06/24 08:36:13 yS1  locking the line
06/24 08:36:13 yS1   makelock(ttyS1) called
06/24 08:36:13 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
06/24 08:36:13 yS1   lock made
06/24 08:36:14 yS1   tio_get_rs232_lines: status: RTS CTS DSR DTR
06/24 08:36:14 yS1  lowering DTR to reset Modem
06/24 08:36:15 yS1   tss: set speed to 115200 (10002)
06/24 08:36:15 yS1   tio_set_flow_control( HARD )
06/24 08:36:15 yS1   waiting for line to clear (VTIME), read: 
06/24 08:36:15 yS1  send: \d\d\d+++\d\d\dATZ[0d]
06/24 08:36:18 yS1  waiting for ``OK''
06/24 08:36:18 yS1   got: ATZ[0d][0d][0a]OK ** found **
06/24 08:36:18 yS1  send: AT&FS2=255S40=124S7=90M0[0d]
06/24 08:36:18 yS1  waiting for ``OK''
06/24 08:36:18 yS1   got: [0d][0a]AT&FS2=255S40=124S7=90M0[0d][0d][0a]OK ** found **
06/24 08:36:18 yS1  send: ATN3S0=0S13.2=1[0d]
06/24 08:36:18 yS1  waiting for ``OK''
06/24 08:36:18 yS1   got: [0d][0a]ATN3S0=0S13.2=1[0d][0d][0a]OK ** found **
06/24 08:36:18 yS1  send: AT[0d]
06/24 08:36:18 yS1  do_stat: expect 'OK' ** found **
06/24 08:36:18 yS1  send: ATI2[0d]
06/24 08:36:18 yS1  do_stat: expect 'OK' ** found **


06/24 08:36:19 yS1  mdm_send: 'AT+FCLASS=2'
06/24 08:36:19 yS1   mdm_command: string 'AT+FCLASS=2'
06/24 08:36:29 yS1  Warning: got alarm signal!
06/24 08:36:29 yS1  mdm_read_byte: read returned -1: Interrupted system call
06/24 08:36:29 yS1  mdm_get_line: cannot read byte, return: Interrupted system call -> ERROR
06/24 08:36:29 yS1   no class 2/2.0 faxmodem, no faxing available
06/24 08:36:29 yS1   tss: set speed to 115200 (10002)
06/24 08:36:29 yS1   tio_set_flow_control( HARD )


	!!!!!!!!!!!!!!!! Here is the complaint.


06/24 08:36:29 yS1  detecting voice modem type
06/24 08:36:29 yS1   voice command: '' -> 'OK|ATE1'
06/24 08:36:29 yS1   voice command: 'ATI' -> ''
06/24 08:36:29 yS1  ZyXEL 2864 detected
06/24 08:36:29 yS1  initializing ZyXEL 2864 voice modem
06/24 08:36:29 yS1   voice command: 'ATS48.5=1' -> 'OK'
06/24 08:36:29 yS1   voice command: 'ATS40.3=1 S40.4=1 S40.5=1 S40.6=1' -> 'OK'
06/24 08:36:30 yS1   voice command: 'AT+VIT=100' -> 'OK'
06/24 08:36:30 yS1   voice command: 'AT+VDD=6,6' -> 'OK'
06/24 08:36:30 yS1   voice command: 'AT+VSD=12,70' -> 'OK'
06/24 08:36:30 yS1   voice command: 'AT+VGT=128' -> 'OK'
06/24 08:36:30 yS1   voice command: 'AT+VGR=128' -> 'OK'
06/24 08:36:30 yS1   waiting for line to clear (VTIME), read: 
06/24 08:36:31 yS1   removing lock file
06/24 08:36:31 yS1  waiting...


Here is a log excerpt of a fax call:

06/25 08:52:00 yS1  checking if modem is still alive
06/25 08:52:00 yS1   makelock(ttyS1) called
06/25 08:52:00 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
06/25 08:52:00 yS1   lock made
06/25 08:52:00 yS1  mdm_send: 'AT'
06/25 08:52:00 yS1   mdm_command: string 'AT'
06/25 08:52:00 yS1   mdm_command: string 'OK' -> OK
06/25 08:52:00 yS1   waiting for line to clear (VTIME), read: 
06/25 08:52:00 yS1   removing lock file
06/25 08:52:00 yS1  waiting...
06/25 09:00:20 yS1   checking lockfiles, locking the line
06/25 09:00:20 yS1   makelock(ttyS1) called
06/25 09:00:20 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
06/25 09:00:20 yS1   lock made
06/25 09:00:20 yS1  waiting for ``RING_''
06/25 09:00:20 yS1   got: TIME: 06-25 09:00 [0d][0a]CALLER NUMBER: 8479340643[0d][0a]CALLER NAME: KWIK KOPY PRNTG[0d][0a][0d][0a]RING 2
06/25 09:00:25 yS1  found action string: ``RING 2''
06/25 09:00:25 yS1  waiting for ``RING_''
06/25 09:00:25 yS1   got: [0d][0a][0d][0a]RING 2
06/25 09:00:31 yS1  found action string: ``RING 2''
06/25 09:00:32 yS1  reading ring_type ring2 configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf
06/25 09:00:32 yS1   reading /usr/local/etc/mgetty+sendfax/voice.conf...
06/25 09:00:32 yS1   conf lib: read: 'part generic'
06/25 09:00:32 yS1   found CT_KEYWORD part generic
06/25 09:00:32 yS1   conf lib: read: 'voice_log_level 5'
06/25 09:00:32 yS1   conf lib: read: 'voice_dir /var/spool/voice'
06/25 09:00:32 yS1   conf lib: read: 'message_flag_file .flag'
06/25 09:00:32 yS1   conf lib: read: 'receive_dir incoming'
06/25 09:00:32 yS1   conf lib: read: 'message_dir messages'
06/25 09:00:32 yS1   conf lib: read: 'message_list Index'
06/25 09:00:32 yS1   conf lib: read: 'backup_message standard.rmd'
06/25 09:00:32 yS1   conf lib: read: 'port_speed 115200'
06/25 09:00:32 yS1   conf lib: read: 'voice_shell /bin/sh'
06/25 09:00:32 yS1   conf lib: read: 'port_timeout 10'
06/25 09:00:32 yS1   conf lib: read: 'dial_timeout 90'
06/25 09:00:32 yS1   conf lib: read: 'command_delay 150'
06/25 09:00:32 yS1   conf lib: read: 'dtmf_len 30'
06/25 09:00:32 yS1   conf lib: read: 'dtmf_threshold 40'
06/25 09:00:32 yS1   conf lib: read: 'dtmf_wait 7'
06/25 09:00:32 yS1   conf lib: read: 'ignore_fax_dle false'
06/25 09:00:32 yS1   conf lib: read: 'raw_data false'
06/25 09:00:32 yS1   conf lib: read: 'rec_compression 4'
06/25 09:00:32 yS1   conf lib: read: 'rec_speed 9600'
06/25 09:00:32 yS1   conf lib: read: 'rec_silence_len 70'
06/25 09:00:32 yS1   conf lib: read: 'rec_silence_threshold 40'
06/25 09:00:32 yS1   conf lib: read: 'rec_remove_silence true'
06/25 09:00:32 yS1   conf lib: read: 'rec_max_len 300'
06/25 09:00:32 yS1   conf lib: read: 'rec_min_len 0'
06/25 09:00:32 yS1   conf lib: read: 'do_hard_flow true'
06/25 09:00:32 yS1   conf lib: read: 'beep_frequency 933'
06/25 09:00:32 yS1   conf lib: read: 'beep_length 150'
06/25 09:00:32 yS1   conf lib: read: 'max_tries 3'
06/25 09:00:32 yS1   conf lib: read: 'retry_delay 5'
06/25 09:00:32 yS1   conf lib: read: 'watchdog_timeout 90'
06/25 09:00:32 yS1   conf lib: read: 'receive_gain -1'
06/25 09:00:32 yS1   conf lib: read: 'transmit_gain -1'
06/25 09:00:32 yS1   conf lib: read: 'enable_command_echo true'
06/25 09:00:32 yS1   conf lib: read: 'program vgetty'
06/25 09:00:32 yS1   conf lib: read: 'speaker_answer_volume 100'
06/25 09:00:32 yS1   conf lib: read: 'rings 2'
06/25 09:00:32 yS1   conf lib: read: 'force_autodetect false'
06/25 09:00:32 yS1   conf lib: read: 'rec_always_keep false'
06/25 09:00:32 yS1   conf lib: read: 'button_program '
06/25 09:00:32 yS1   conf lib: read: 'call_program '
06/25 09:00:32 yS1   conf lib: read: 'dtmf_program dtmf.sh'
06/25 09:00:32 yS1   conf lib: read: 'message_program /home/rj/scripts/voicemail_rcvd'
06/25 09:00:32 yS1   conf lib: read: 'do_message_light false'
06/25 09:00:32 yS1   conf lib: read: 'program vm'
06/25 09:00:32 yS1   conf lib: read: 'voice_devices ttyS1'
06/25 09:00:32 yS1   conf lib: read: 'dialout_timeout 90'
06/25 09:00:32 yS1   conf lib: read: 'speaker_play_volume 100'
06/25 09:00:32 yS1   conf lib: read: 'program pvf'
06/25 09:00:32 yS1   conf lib: read: 'ring_type ring'
06/25 09:00:32 yS1   section: ring_type ring, ignore
06/25 09:00:32 yS1   conf lib: read: 'rings 3'
06/25 09:00:32 yS1   conf lib: read: 'answer_mode voice/fax'
06/25 09:00:32 yS1   conf lib: read: 'ring_type ring2'
06/25 09:00:32 yS1   section: ring_type ring2, **found**
06/25 09:00:32 yS1   conf lib: read: 'rings 2'
06/25 09:00:32 yS1   conf lib: read: 'answer_mode data'
06/25 09:00:32 yS1   conf lib: read: 'ring_type ring4'
06/25 09:00:32 yS1   section: ring_type ring4, ignore
06/25 09:00:32 yS1   conf lib: read: 'rings 2'
06/25 09:00:32 yS1   conf lib: read: 'answer_mode /usr/local/etc/mgetty+sendfax/answer/ring4'
06/25 09:00:32 yS1   conf lib: read: 'answer_mode fax'
06/25 09:00:32 yS1   key: 'part', type=6, flags=4, data=(ignored)
06/25 09:00:32 yS1   key: 'program', type=6, flags=4, data=(ignored)
06/25 09:00:32 yS1   key: 'port', type=6, flags=4, data=(ignored)
06/25 09:00:32 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
06/25 09:00:32 yS1   key: 'voice_log_level', type=0, flags=3, data=5
06/25 09:00:32 yS1   key: 'voice_devices', type=1, flags=0, data=(empty)
06/25 09:00:32 yS1   key: 'port_speed', type=0, flags=3, data=115200
06/25 09:00:32 yS1   key: 'port_timeout', type=0, flags=3, data=10
06/25 09:00:32 yS1   key: 'dtmf_len', type=0, flags=3, data=30
06/25 09:00:32 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
06/25 09:00:32 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
06/25 09:00:32 yS1   key: 'rec_compression', type=0, flags=3, data=4
06/25 09:00:32 yS1   key: 'rec_speed', type=0, flags=3, data=9600
06/25 09:00:32 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
06/25 09:00:32 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
06/25 09:00:32 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
06/25 09:00:32 yS1   key: 'rec_max_len', type=0, flags=3, data=300
06/25 09:00:32 yS1   key: 'receive_gain', type=0, flags=3, data=50
06/25 09:00:32 yS1   key: 'transmit_gain', type=0, flags=3, data=50
06/25 09:00:32 yS1   key: 'rings', type=1, flags=3, data=2
06/25 09:00:32 yS1   key: 'answer_mode', type=1, flags=3, data=data
06/25 09:00:32 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
06/25 09:00:32 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
06/25 09:00:32 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
06/25 09:00:32 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
06/25 09:00:32 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
06/25 09:00:32 yS1   key: 'message_dir', type=1, flags=3, data=messages
06/25 09:00:32 yS1   key: 'message_list', type=1, flags=3, data=Index
06/25 09:00:32 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
06/25 09:00:32 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
06/25 09:00:32 yS1   key: 'beep_frequency', type=0, flags=3, data=933
06/25 09:00:32 yS1   key: 'beep_length', type=0, flags=3, data=150
06/25 09:00:32 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
06/25 09:00:32 yS1   key: 'max_tries', type=0, flags=3, data=3
06/25 09:00:32 yS1   key: 'retry_delay', type=0, flags=3, data=5
06/25 09:00:32 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
06/25 09:00:32 yS1   key: 'button_program', type=1, flags=3, data=
06/25 09:00:32 yS1   key: 'call_program', type=1, flags=3, data=
06/25 09:00:32 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
06/25 09:00:32 yS1   key: 'message_program', type=1, flags=3, data=/home/rj/scripts/voicemail_rcvd
06/25 09:00:32 yS1   key: 'do_message_light', type=3, flags=3, data=FALSE
06/25 09:00:32 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
06/25 09:00:32 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
06/25 09:00:32 yS1   key: 'watchdog_timeout', type=0, flags=3, data=90
06/25 09:00:32 yS1   key: 'rec_min_len', type=0, flags=3, data=0
06/25 09:00:32 yS1   key: 'command_delay', type=0, flags=3, data=150
06/25 09:00:32 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
06/25 09:00:32 yS1   key: 'dial_timeout', type=0, flags=3, data=90
06/25 09:00:32 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
06/25 09:00:32 yS1   voice command: 'AT+FCLASS=0' -> 'OK'
06/25 09:00:32 yS1   voice command: 'AT+FAA=0' -> 'OK'
06/25 09:00:32 yS1   vgetty: Restoring signal handlers
06/25 09:00:32 yS1   vgetty: No signal handlers were installed
06/25 09:00:32 yS1  send: ATA[0d]
06/25 09:00:32 yS1  waiting for ``CONNECT''
06/25 09:00:32 yS1   got: ATA[0d][0d][0a]+FCON
06/25 09:00:43 yS1  found action string: ``+FCON''
06/25 09:00:43 yS1  start fax receiver...
06/25 09:00:43 yS1   fax receiver: entry
06/25 09:00:43 yS1  fax_wait_for(OK)
06/25 09:00:45 yS1   fax_wait_for: string '+FTSI:        847 934 0643 '
06/25 09:00:45 yS1  fax_id: '+FTSI:        847 934 0643 '
06/25 09:00:45 yS1   fax_wait_for: string '+FDCS:0,3,0,2,0,0,0,1'
06/25 09:00:45 yS1  transmission par.: '+FDCS:0,3,0,2,0,0,0,1'
06/25 09:00:45 yS1   fax_wait_for: string 'OK'** found **
06/25 09:00:45 yS1   utmp + wtmp entry made
06/25 09:00:45 yS1   tio_set_flow_control( HARD XON_IN )
06/25 09:00:45 yS1  fax_send: 'AT+FDR'
06/25 09:00:45 yS1  fax_wait_for(CONNECT)
06/25 09:00:45 yS1   fax_wait_for: string 'AT+FDR'
06/25 09:00:47 yS1   fax_wait_for: string '+FCFR'
06/25 09:00:47 yS1   fax_wait_for: string '+FDCS:0,3,0,2,0,0,0,1'
06/25 09:00:47 yS1  transmission par.: '+FDCS:0,3,0,2,0,0,0,1'
06/25 09:00:47 yS1   fax_wait_for: string 'CONNECT'** found **
06/25 09:00:47 yS1   sending DC2
06/25 09:00:48 yS1   fax_get_page_data: wait for EOL, got: [0a][00]
06/25 09:00:48 yS1  fax_get_page_data: receiving /var/spool/fax/incoming/fn59257ffS1-847-934-0643.01...
06/25 09:01:08 yS1  fax_get_page_data: page end, bytes received: 25397
06/25 09:01:08 yS1  fax_wait_for(OK)
06/25 09:01:08 yS1   fax_wait_for: string '+FPTS:1,543,0,0,0'
06/25 09:01:08 yS1  page status: +FPTS:1,543,0,0,0
06/25 09:01:08 yS1   543 lines received, 0 lines bad, 0 bytes lost
06/25 09:01:10 yS1   fax_wait_for: string '+FET:2'
06/25 09:01:10 yS1   fax_wait_for: string 'OK'** found **
06/25 09:01:10 yS1  fax_send: 'AT+FDR'
06/25 09:01:10 yS1  fax_wait_for(CONNECT)
06/25 09:01:10 yS1   fax_wait_for: string 'AT+FDR'
06/25 09:01:13 yS1   fax_wait_for: string '+FHNG:00'
06/25 09:01:13 yS1  connection hangup: '+FHNG:00'
06/25 09:01:13 yS1   (Normal and proper end of connection)** found **
06/25 09:01:13 yS1   fax receiver: hangup & end
06/25 09:01:13 yS1   fax_notify_mail: sending mail to: faxadmin
06/25 09:01:13 yS1   notify: '/usr/local/lib/mgetty+sendfax/new_fax 0 '847 934 0643 ' 1  /var/spool/fax/incoming/fn59257ffS1-847-934-0643.01 >/dev/console 2>&1 </dev/null'
06/25 09:01:13 ##### fax dev=ttyS1, pid=20504, caller=8479340643, name='KWIK KOPY PRNTG', id='847 934 0643 ', +FHNG=000, pages=1, time=00:00:42_

06/25 09:01:15 yS1  mdm_send: 'ATH0'
06/25 09:01:15 yS1   mdm_command: string 'OK' -> OK
06/25 09:01:15 yS1   removing lock file
--
06/25 09:01:15 yS1  vgetty: experimental test release 0.7.3 / 10Aug97
06/25 09:01:15 yS1  mgetty: experimental test release 1.1.9-Aug17
06/25 09:01:15 yS1  reading generic configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf
06/25 09:01:15 yS1  reading program vgetty configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf
06/25 09:01:15 yS1  something foul in config line: 'speaker_answer_volume 100'
06/25 09:01:15 yS1      (keyword 'speaker_answer_volume' not found)
06/25 09:01:15 yS1  reading port ttyS1 configuration from config file /usr/local/etc/mgetty+sendfax/voice.conf
06/25 09:01:15 yS1   reading /usr/local/etc/mgetty+sendfax/voice.conf...
06/25 09:01:15 yS1   conf lib: read: 'part generic'
06/25 09:01:15 yS1   found CT_KEYWORD part generic
06/25 09:01:15 yS1   conf lib: read: 'voice_log_level 5'
06/25 09:01:15 yS1   conf lib: read: 'voice_dir /var/spool/voice'
06/25 09:01:15 yS1   conf lib: read: 'message_flag_file .flag'
06/25 09:01:15 yS1   conf lib: read: 'receive_dir incoming'
06/25 09:01:15 yS1   conf lib: read: 'message_dir messages'
06/25 09:01:15 yS1   conf lib: read: 'message_list Index'
06/25 09:01:15 yS1   conf lib: read: 'backup_message standard.rmd'
06/25 09:01:15 yS1   conf lib: read: 'port_speed 115200'
06/25 09:01:15 yS1   conf lib: read: 'voice_shell /bin/sh'
06/25 09:01:15 yS1   conf lib: read: 'port_timeout 10'
06/25 09:01:15 yS1   conf lib: read: 'dial_timeout 90'
06/25 09:01:15 yS1   conf lib: read: 'command_delay 150'
06/25 09:01:15 yS1   conf lib: read: 'dtmf_len 30'
06/25 09:01:15 yS1   conf lib: read: 'dtmf_threshold 40'
06/25 09:01:15 yS1   conf lib: read: 'dtmf_wait 7'
06/25 09:01:15 yS1   conf lib: read: 'ignore_fax_dle false'
06/25 09:01:15 yS1   conf lib: read: 'raw_data false'
06/25 09:01:15 yS1   conf lib: read: 'rec_compression 4'
06/25 09:01:15 yS1   conf lib: read: 'rec_speed 9600'
06/25 09:01:15 yS1   conf lib: read: 'rec_silence_len 70'
06/25 09:01:15 yS1   conf lib: read: 'rec_silence_threshold 40'
06/25 09:01:15 yS1   conf lib: read: 'rec_remove_silence true'
06/25 09:01:15 yS1   conf lib: read: 'rec_max_len 300'
06/25 09:01:15 yS1   conf lib: read: 'rec_min_len 0'
06/25 09:01:15 yS1   conf lib: read: 'do_hard_flow true'
06/25 09:01:15 yS1   conf lib: read: 'beep_frequency 933'
06/25 09:01:15 yS1   conf lib: read: 'beep_length 150'
06/25 09:01:15 yS1   conf lib: read: 'max_tries 3'
06/25 09:01:15 yS1   conf lib: read: 'retry_delay 5'
06/25 09:01:15 yS1   conf lib: read: 'watchdog_timeout 90'
06/25 09:01:15 yS1   conf lib: read: 'receive_gain -1'
06/25 09:01:15 yS1   conf lib: read: 'transmit_gain -1'
06/25 09:01:15 yS1   conf lib: read: 'enable_command_echo true'
06/25 09:01:15 yS1   conf lib: read: 'program vgetty'
06/25 09:01:15 yS1   conf lib: read: 'speaker_answer_volume 100'
06/25 09:01:15 yS1   conf lib: read: 'rings 2'
06/25 09:01:15 yS1   conf lib: read: 'force_autodetect false'
06/25 09:01:15 yS1   conf lib: read: 'rec_always_keep false'
06/25 09:01:15 yS1   conf lib: read: 'button_program '
06/25 09:01:15 yS1   conf lib: read: 'call_program '
06/25 09:01:15 yS1   conf lib: read: 'dtmf_program dtmf.sh'
06/25 09:01:15 yS1   conf lib: read: 'message_program /home/rj/scripts/voicemail_rcvd'
06/25 09:01:15 yS1   conf lib: read: 'do_message_light false'
06/25 09:01:15 yS1   conf lib: read: 'program vm'
06/25 09:01:15 yS1   conf lib: read: 'voice_devices ttyS1'
06/25 09:01:15 yS1   conf lib: read: 'dialout_timeout 90'
06/25 09:01:15 yS1   conf lib: read: 'speaker_play_volume 100'
06/25 09:01:15 yS1   conf lib: read: 'program pvf'
06/25 09:01:15 yS1   conf lib: read: 'ring_type ring'
06/25 09:01:15 yS1   conf lib: read: 'rings 3'
06/25 09:01:15 yS1   conf lib: read: 'answer_mode voice/fax'
06/25 09:01:15 yS1   conf lib: read: 'ring_type ring2'
06/25 09:01:15 yS1   conf lib: read: 'rings 2'
06/25 09:01:15 yS1   conf lib: read: 'answer_mode data'
06/25 09:01:15 yS1   conf lib: read: 'ring_type ring4'
06/25 09:01:15 yS1   conf lib: read: 'rings 2'
06/25 09:01:15 yS1   conf lib: read: 'answer_mode /usr/local/etc/mgetty+sendfax/answer/ring4'
06/25 09:01:15 yS1   conf lib: read: 'answer_mode fax'
06/25 09:01:15 yS1   key: 'part', type=6, flags=4, data=(ignored)
06/25 09:01:15 yS1   key: 'program', type=6, flags=4, data=(ignored)
06/25 09:01:15 yS1   key: 'port', type=6, flags=4, data=(ignored)
06/25 09:01:15 yS1   key: 'ring_type', type=6, flags=4, data=(ignored)
06/25 09:01:15 yS1   key: 'voice_log_level', type=0, flags=3, data=5
06/25 09:01:15 yS1   key: 'voice_devices', type=1, flags=0, data=(empty)
06/25 09:01:15 yS1   key: 'port_speed', type=0, flags=3, data=115200
06/25 09:01:15 yS1   key: 'port_timeout', type=0, flags=3, data=10
06/25 09:01:15 yS1   key: 'dtmf_len', type=0, flags=3, data=30
06/25 09:01:15 yS1   key: 'dtmf_threshold', type=0, flags=3, data=40
06/25 09:01:15 yS1   key: 'dtmf_wait', type=0, flags=3, data=7
06/25 09:01:15 yS1   key: 'rec_compression', type=0, flags=3, data=4
06/25 09:01:15 yS1   key: 'rec_speed', type=0, flags=3, data=9600
06/25 09:01:15 yS1   key: 'rec_silence_len', type=0, flags=3, data=70
06/25 09:01:15 yS1   key: 'rec_silence_threshold', type=0, flags=3, data=40
06/25 09:01:15 yS1   key: 'rec_remove_silence', type=3, flags=3, data=TRUE
06/25 09:01:15 yS1   key: 'rec_max_len', type=0, flags=3, data=300
06/25 09:01:15 yS1   key: 'receive_gain', type=0, flags=3, data=-1
06/25 09:01:15 yS1   key: 'transmit_gain', type=0, flags=3, data=-1
06/25 09:01:15 yS1   key: 'rings', type=1, flags=3, data=2
06/25 09:01:15 yS1   key: 'answer_mode', type=1, flags=1, data=voice:fax:data
06/25 09:01:15 yS1   key: 'toll_saver_rings', type=0, flags=1, data=0
06/25 09:01:15 yS1   key: 'rec_always_keep', type=3, flags=3, data=FALSE
06/25 09:01:15 yS1   key: 'voice_dir', type=1, flags=3, data=/var/spool/voice
06/25 09:01:15 yS1   key: 'message_flag_file', type=1, flags=3, data=.flag
06/25 09:01:15 yS1   key: 'receive_dir', type=1, flags=3, data=incoming
06/25 09:01:15 yS1   key: 'message_dir', type=1, flags=3, data=messages
06/25 09:01:15 yS1   key: 'message_list', type=1, flags=3, data=Index
06/25 09:01:15 yS1   key: 'backup_message', type=1, flags=3, data=standard.rmd
06/25 09:01:15 yS1   key: 'dialout_timeout', type=0, flags=1, data=90
06/25 09:01:15 yS1   key: 'beep_frequency', type=0, flags=3, data=933
06/25 09:01:15 yS1   key: 'beep_length', type=0, flags=3, data=150
06/25 09:01:15 yS1   key: 'raw_data', type=3, flags=3, data=FALSE
06/25 09:01:15 yS1   key: 'max_tries', type=0, flags=3, data=3
06/25 09:01:15 yS1   key: 'retry_delay', type=0, flags=3, data=5
06/25 09:01:15 yS1   key: 'voice_shell', type=1, flags=3, data=/bin/sh
06/25 09:01:15 yS1   key: 'button_program', type=1, flags=3, data=
06/25 09:01:15 yS1   key: 'call_program', type=1, flags=3, data=
06/25 09:01:15 yS1   key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
06/25 09:01:15 yS1   key: 'message_program', type=1, flags=3, data=/home/rj/scripts/voicemail_rcvd
06/25 09:01:15 yS1   key: 'do_message_light', type=3, flags=3, data=FALSE
06/25 09:01:15 yS1   key: 'do_hard_flow', type=3, flags=3, data=TRUE
06/25 09:01:15 yS1   key: 'force_autodetect', type=3, flags=3, data=FALSE
06/25 09:01:15 yS1   key: 'watchdog_timeout', type=0, flags=3, data=90
06/25 09:01:15 yS1   key: 'rec_min_len', type=0, flags=3, data=0
06/25 09:01:15 yS1   key: 'command_delay', type=0, flags=3, data=150
06/25 09:01:15 yS1   key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
06/25 09:01:15 yS1   key: 'dial_timeout', type=0, flags=3, data=90
06/25 09:01:15 yS1   key: 'enable_command_echo', type=3, flags=3, data=TRUE
06/25 09:01:15 yS1  check for lockfiles
06/25 09:01:15 yS1   checklock: stat failed, no file
06/25 09:01:15 yS1  locking the line
06/25 09:01:15 yS1   makelock(ttyS1) called
06/25 09:01:15 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
06/25 09:01:15 yS1   lock made
06/25 09:01:16 yS1   tio_get_rs232_lines: status: RTS CTS DSR DTR
06/25 09:01:16 yS1  lowering DTR to reset Modem
06/25 09:01:17 yS1   tss: set speed to 115200 (10002)
06/25 09:01:17 yS1   tio_set_flow_control( HARD )
06/25 09:01:17 yS1   waiting for line to clear (VTIME), read: 
06/25 09:01:17 yS1  send: \d\d\d+++\d\d\dATZ[0d]
06/25 09:01:20 yS1  waiting for ``OK''
06/25 09:01:20 yS1   got: ATZ[0d][0d][0a]OK ** found **
06/25 09:01:21 yS1  send: AT&FS2=255S40=124S7=90M0[0d]
06/25 09:01:21 yS1  waiting for ``OK''
06/25 09:01:21 yS1   got: [0d][0a]AT&FS2=255S40=124S7=90M0[0d][0d][0a]OK ** found **
06/25 09:01:21 yS1  send: ATN3S0=0S13.2=1[0d]
06/25 09:01:21 yS1  waiting for ``OK''
06/25 09:01:21 yS1   got: [0d][0a]ATN3S0=0S13.2=1[0d][0d][0a]OK ** found **
06/25 09:01:21 yS1  send: AT[0d]
06/25 09:01:21 yS1  do_stat: expect 'OK' ** found **
06/25 09:01:21 yS1  send: ATI2[0d]
06/25 09:01:21 yS1  do_stat: expect 'OK' ** found **
06/25 09:01:21 yS1  mdm_send: 'AT+FCLASS=2'
06/25 09:01:21 yS1   mdm_command: string 'AT+FCLASS=2'
06/25 09:01:21 yS1   mdm_command: string 'OK' -> OK
06/25 09:01:21 yS1  mdm_send: 'AT+FCLASS=0'
06/25 09:01:21 yS1   mdm_command: string 'AT+FCLASS=0'
06/25 09:01:21 yS1   mdm_command: string 'OK' -> OK
06/25 09:01:21 yS1  mdm_send: 'AT+FAA=1;+FCR=1'
06/25 09:01:21 yS1   mdm_command: string 'AT+FAA=1;+FCR=1'
06/25 09:01:21 yS1   mdm_command: string 'OK' -> OK
06/25 09:01:21 yS1  mdm_send: 'AT+FBOR=0'
06/25 09:01:21 yS1   mdm_command: string 'AT+FBOR=0'
06/25 09:01:21 yS1   mdm_command: string 'OK' -> OK
06/25 09:01:21 yS1  mdm_send: 'AT+FLID="1 847 705 4925"'
06/25 09:01:21 yS1   mdm_command: string 'AT+FLID="1 847 705 4925"'
06/25 09:01:21 yS1   mdm_command: string 'OK' -> OK
06/25 09:01:22 yS1  mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
06/25 09:01:22 yS1   mdm_command: string 'AT+FDCC=1,5,0,2,0,0,0,0'
06/25 09:01:22 yS1   mdm_command: string 'OK' -> OK
06/25 09:01:22 yS1   tss: set speed to 115200 (10002)
06/25 09:01:22 yS1   tio_set_flow_control( HARD )
06/25 09:01:22 yS1  detecting voice modem type
06/25 09:01:22 yS1   voice command: '' -> 'OK|ATE1'
06/25 09:01:22 yS1   voice command: 'ATI' -> ''
06/25 09:01:22 yS1  ZyXEL 2864 detected
06/25 09:01:22 yS1  initializing ZyXEL 2864 voice modem
06/25 09:01:22 yS1   voice command: 'ATS48.5=1' -> 'OK'
06/25 09:01:22 yS1   voice command: 'ATS40.3=1 S40.4=1 S40.5=1 S40.6=1' -> 'OK'
06/25 09:01:23 yS1   voice command: 'AT+VIT=100' -> 'OK'
06/25 09:01:23 yS1   voice command: 'AT+VDD=6,6' -> 'OK'
06/25 09:01:23 yS1   voice command: 'AT+VSD=12,70' -> 'OK'
06/25 09:01:23 yS1   voice command: 'AT+VGT=128' -> 'OK'
06/25 09:01:23 yS1   voice command: 'AT+VGR=128' -> 'OK'
06/25 09:01:23 yS1   waiting for line to clear (VTIME), read: 
06/25 09:01:24 yS1   removing lock file
06/25 09:01:24 yS1  waiting...
06/25 10:01:24 yS1  checking if modem is still alive
06/25 10:01:24 yS1   makelock(ttyS1) called
06/25 10:01:24 yS1   do_makelock: lock='/var/lock/LCK..ttyS1'
06/25 10:01:24 yS1   lock made
06/25 10:01:24 yS1  mdm_send: 'AT'
06/25 10:01:24 yS1   mdm_command: string 'AT'
06/25 10:01:24 yS1   mdm_command: string 'OK' -> OK
06/25 10:01:24 yS1   waiting for line to clear (VTIME), read: 
06/25 10:01:24 yS1   removing lock file
06/25 10:01:24 yS1  waiting...


-- 
--------  "And there came a writing to him from Elijah"  [2Ch 21:12]  --------
R. J. Brown III  rj@elilabs.com http://www.elilabs.com/~rj  voice 847 543-4060
Elijah Laboratories Inc. 457 Signal Lane, Grayslake IL 60030  fax 847 543-4061
-----  M o d e l i n g   t h e   M e t h o d s   o f   t h e   M i n d  ------