elsa microlink hangs
Martin Lorenz (a9026080@unet.univie.ac.at)
Thu, 23 Jul 1998 17:24:13 +0200
strange: one time it works (records a message) and from that time on it
refuses to pick up for the next <i dont know how much> hours
here's another logfile (the most recent one showing first a working and
secondly a broken voice-call
sorry for the huge amount of data - it's log level 6 for both vgetty and
mgetty
07/23 08:41:33 yS1 select returned 0
07/23 08:41:33 yS1 checking if modem is still alive
07/23 08:41:33 yS1 makelock(ttyS1) called
07/23 08:41:33 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
07/23 08:41:33 yS1 lock made
07/23 08:41:33 yS1 mdm_send: 'AT'
07/23 08:41:33 yS1 got:[0a]AT[0d]
07/23 08:41:33 yS1 mdm_command: string 'AT'
07/23 08:41:33 yS1 got:[0d][0a]OK[0d]
07/23 08:41:33 yS1 mdm_command: string 'OK' -> OK
07/23 08:41:33 yS1 waiting for line to clear (VTIME), read:
07/23 08:41:33 yS1 removing lock file
07/23 08:41:33 yS1 waiting...
07/23 09:03:37 yS1 select returned 1
07/23 09:03:37 yS1 checking lockfiles, locking the line
07/23 09:03:37 yS1 makelock(ttyS1) called
07/23 09:03:37 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
07/23 09:03:37 yS1 lock made
07/23 09:03:37 yS1 vgetty: number of rings (3) was set directly
07/23 09:03:37 yS1 vgetty: decremented number of rings (3) by 0
07/23 09:03:37 yS1 wfr: waiting for ``RING''
07/23 09:03:37 yS1 got: [0a][0d][0a]RING[0d]
07/23 09:03:37 yS1 CND: RING
07/23 09:03:37 yS1 wfr: rc=0, drn=0
07/23 09:03:37 yS1 wfr: waiting for ``RING''
07/23 09:03:37 yS1 got: [0a][0d][0a]RING[0d]
07/23 09:03:43 yS1 CND: RING
07/23 09:03:43 yS1 wfr: rc=0, drn=0
07/23 09:03:43 yS1 wfr: waiting for ``RING''
07/23 09:03:43 yS1 got: [0a][0d][0a]RING[0d]
07/23 09:03:49 yS1 CND: RING
07/23 09:03:49 yS1 wfr: rc=0, drn=0
07/23 09:03:49 yS1 reading ring_type ring configuration from config
file /etc/mgetty+sendfax/voice.conf
07/23 09:03:49 yS1 reading /etc/mgetty+sendfax/voice.conf...
07/23 09:03:49 yS1 conf lib: read: 'part generic'
07/23 09:03:49 yS1 found CT_KEYWORD part generic
07/23 09:03:49 yS1 conf lib: read: 'voice_log_level 9'
07/23 09:03:49 yS1 conf lib: read: 'voice_dir /usr/local/spool/voice'
07/23 09:03:49 yS1 conf lib: read: 'phone_owner root'
07/23 09:03:49 yS1 conf lib: read: 'phone_group private'
07/23 09:03:49 yS1 conf lib: read: 'phone_mode 0660'
07/23 09:03:49 yS1 conf lib: read: 'message_flag_file .flag'
07/23 09:03:49 yS1 conf lib: read: 'receive_dir incoming'
07/23 09:03:49 yS1 conf lib: read: 'message_dir messages'
07/23 09:03:49 yS1 conf lib: read: 'message_list Index'
07/23 09:03:49 yS1 conf lib: read: 'backup_message standard.rmd'
07/23 09:03:49 yS1 conf lib: read: 'port_speed 115200'
07/23 09:03:49 yS1 conf lib: read: 'voice_shell /bin/sh'
07/23 09:03:49 yS1 conf lib: read: 'port_timeout 10'
07/23 09:03:49 yS1 conf lib: read: 'dial_timeout 90'
07/23 09:03:49 yS1 conf lib: read: 'command_delay 100'
07/23 09:03:49 yS1 conf lib: read: 'dtmf_len 30'
07/23 09:03:49 yS1 conf lib: read: 'dtmf_threshold 40'
07/23 09:03:49 yS1 conf lib: read: 'dtmf_wait 7'
07/23 09:03:49 yS1 conf lib: read: 'ignore_fax_dle false'
07/23 09:03:49 yS1 conf lib: read: 'raw_data false'
07/23 09:03:49 yS1 conf lib: read: 'rec_compression 4'
07/23 09:03:49 yS1 conf lib: read: 'rec_speed 0'
07/23 09:03:49 yS1 conf lib: read: 'rec_silence_len 70'
07/23 09:03:49 yS1 conf lib: read: 'rec_silence_threshold 40'
07/23 09:03:49 yS1 conf lib: read: 'rec_remove_silence false'
07/23 09:03:49 yS1 conf lib: read: 'rec_max_len 300'
07/23 09:03:49 yS1 conf lib: read: 'rec_min_len 0'
07/23 09:03:49 yS1 conf lib: read: 'do_hard_flow true'
07/23 09:03:49 yS1 conf lib: read: 'beep_frequency 933'
07/23 09:03:49 yS1 conf lib: read: 'beep_length 1500'
07/23 09:03:49 yS1 conf lib: read: 'max_tries 3'
07/23 09:03:49 yS1 conf lib: read: 'retry_delay 5'
07/23 09:03:49 yS1 conf lib: read: 'watchdog_timeout 60'
07/23 09:03:49 yS1 conf lib: read: 'receive_gain -1'
07/23 09:03:49 yS1 conf lib: read: 'transmit_gain -1'
07/23 09:03:49 yS1 conf lib: read: 'enable_command_echo true'
07/23 09:03:49 yS1 conf lib: read: 'poll_interval 10'
07/23 09:03:49 yS1 conf lib: read: 'program vgetty'
07/23 09:03:49 yS1 conf lib: read: 'rings 3'
07/23 09:03:49 yS1 conf lib: read: 'answer_mode voice:fax:data'
07/23 09:03:49 yS1 conf lib: read: 'force_autodetect false'
07/23 09:03:49 yS1 conf lib: read: 'toll_saver_rings 0'
07/23 09:03:49 yS1 conf lib: read: 'rec_always_keep true'
07/23 09:03:49 yS1 conf lib: read: 'button_program '
07/23 09:03:49 yS1 conf lib: read: 'call_program '
07/23 09:03:49 yS1 conf lib: read: 'dtmf_program dtmf.sh'
07/23 09:03:49 yS1 conf lib: read: 'message_program '
07/23 09:03:49 yS1 conf lib: read: 'do_message_light false'
07/23 09:03:49 yS1 conf lib: read: 'program vm'
07/23 09:03:49 yS1 conf lib: read: 'voice_devices ttyS1'
07/23 09:03:49 yS1 conf lib: read: 'dialout_timeout 90'
07/23 09:03:49 yS1 conf lib: read: 'program pvf'
07/23 09:03:49 yS1 conf lib: read: 'port ttyS1'
07/23 09:03:49 yS1 conf lib: read: 'rings 3'
07/23 09:03:49 yS1 conf lib: read: 'ring_type virtual'
07/23 09:03:49 yS1 section: ring_type virtual, ignore
07/23 09:03:49 yS1 conf lib: read: 'answer_mode fax:data'
07/23 09:03:49 yS1 conf lib: read: 'ring_type ring'
07/23 09:03:49 yS1 section: ring_type ring, **found**
07/23 09:03:49 yS1 conf lib: read: 'ring_type ring1'
07/23 09:03:49 yS1 section: ring_type ring1, ignore
07/23 09:03:49 yS1 key: 'part', type=6, flags=4, data=(ignored)
07/23 09:03:49 yS1 key: 'program', type=6, flags=4, data=(ignored)
07/23 09:03:49 yS1 key: 'port', type=6, flags=4, data=(ignored)
07/23 09:03:49 yS1 key: 'ring_type', type=6, flags=4, data=(ignored)
07/23 09:03:49 yS1 key: 'voice_log_level', type=0, flags=3, data=9
07/23 09:03:49 yS1 key: 'voice_shell', type=1, flags=3, data=/bin/sh
07/23 09:03:49 yS1 key: 'port_speed', type=0, flags=3, data=115200
07/23 09:03:49 yS1 key: 'port_timeout', type=0, flags=3, data=10
07/23 09:03:49 yS1 key: 'dial_timeout', type=0, flags=3, data=90
07/23 09:03:49 yS1 key: 'command_delay', type=0, flags=3, data=100
07/23 09:03:49 yS1 key: 'dtmf_len', type=0, flags=3, data=30
07/23 09:03:49 yS1 key: 'dtmf_threshold', type=0, flags=3, data=40
07/23 09:03:49 yS1 key: 'dtmf_wait', type=0, flags=3, data=7
07/23 09:03:49 yS1 key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
07/23 09:03:49 yS1 key: 'raw_data', type=3, flags=3, data=FALSE
07/23 09:03:49 yS1 key: 'rec_compression', type=0, flags=3, data=4
07/23 09:03:49 yS1 key: 'rec_speed', type=0, flags=3, data=0
07/23 09:03:49 yS1 key: 'rec_silence_len', type=0, flags=3, data=70
07/23 09:03:49 yS1 key: 'rec_silence_threshold', type=0, flags=3,
data=40
07/23 09:03:49 yS1 key: 'rec_remove_silence', type=3, flags=3,
data=FALSE
07/23 09:03:49 yS1 key: 'rec_max_len', type=0, flags=3, data=300
07/23 09:03:49 yS1 key: 'rec_min_len', type=0, flags=3, data=0
07/23 09:03:49 yS1 key: 'do_hard_flow', type=3, flags=3, data=TRUE
07/23 09:03:49 yS1 key: 'force_autodetect', type=3, flags=3,
data=FALSE
07/23 09:03:49 yS1 key: 'watchdog_timeout', type=0, flags=3, data=60
07/23 09:03:49 yS1 key: 'receive_gain', type=0, flags=3, data=50
07/23 09:03:49 yS1 key: 'transmit_gain', type=0, flags=3, data=50
07/23 09:03:49 yS1 key: 'enable_command_echo', type=3, flags=3,
data=TRUE
07/23 09:03:49 yS1 key: 'poll_interval', type=0, flags=3, data=10
07/23 09:03:49 yS1 key: 'rings', type=1, flags=3, data=3
07/23 09:03:49 yS1 key: 'answer_mode', type=1, flags=3,
data=voice:fax:data
07/23 09:03:49 yS1 key: 'toll_saver_rings', type=0, flags=3, data=0
07/23 09:03:49 yS1 key: 'rec_always_keep', type=3, flags=3, data=TRUE
07/23 09:03:49 yS1 key: 'voice_dir', type=1, flags=3,
data=/usr/local/spool/voice
07/23 09:03:49 yS1 key: 'phone_owner', type=1, flags=3, data=root
07/23 09:03:49 yS1 key: 'phone_group', type=1, flags=3, data=private
07/23 09:03:49 yS1 key: 'phone_mode', type=0, flags=3, data=432
07/23 09:03:49 yS1 key: 'message_flag_file', type=1, flags=3,
data=.flag
07/23 09:03:49 yS1 key: 'receive_dir', type=1, flags=3, data=incoming
07/23 09:03:49 yS1 key: 'message_dir', type=1, flags=3, data=messages
07/23 09:03:49 yS1 key: 'message_list', type=1, flags=3, data=Index
07/23 09:03:49 yS1 key: 'backup_message', type=1, flags=3,
data=standard.rmd
07/23 09:03:49 yS1 key: 'button_program', type=1, flags=3, data=
07/23 09:03:49 yS1 key: 'call_program', type=1, flags=3, data=
07/23 09:03:49 yS1 key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
07/23 09:03:49 yS1 key: 'message_program', type=1, flags=3, data=
07/23 09:03:49 yS1 key: 'do_message_light', type=3, flags=3,
data=FALSE
07/23 09:03:49 yS1 key: 'beep_frequency', type=0, flags=3, data=933
07/23 09:03:49 yS1 key: 'beep_length', type=0, flags=3, data=1500
07/23 09:03:49 yS1 key: 'max_tries', type=0, flags=3, data=3
07/23 09:03:49 yS1 key: 'retry_delay', type=0, flags=3, data=5
07/23 09:03:49 yS1 key: 'dialout_timeout', type=0, flags=1, data=90
07/23 09:03:49 yS1 key: 'voice_devices', type=1, flags=1, data=
07/23 09:03:49 yS1 vgetty: answer mode was set directly
07/23 09:03:49 yS1 vgetty: answer mode is [data|fax|voice]
07/23 09:03:49 yS1 vgetty: opening list file
/usr/local/spool/voice/messages/Index
07/23 09:03:49 yS1 vgetty: found 5 messages, picked message number 1
07/23 09:03:49 yS1 vgetty: message name is
/usr/local/spool/voice/messages/comphere4.rmd
07/23 09:03:49 yS1 vgetty: entering voice mode
07/23 09:03:49 yS1 vgetty: Installing signal handlers
07/23 09:03:49 yS1 voice command: 'AT#CLS?' -> ''
07/23 09:03:49 yS1 vgetty: AT#CLS?
07/23 09:03:49 yS1 Elsa MicroLink: AT#CLS?
07/23 09:03:49 yS1 Elsa MicroLink: 2
07/23 09:03:49 yS1 voice command: '' -> 'OK'
07/23 09:03:49 yS1 Elsa MicroLink: OK
07/23 09:03:49 yS1 voice command: 'AT#CLS=8' -> 'OK'
07/23 09:03:50 yS1 vgetty: AT#CLS=8
07/23 09:03:50 yS1 Elsa MicroLink: AT#CLS=8
07/23 09:03:50 yS1 Elsa MicroLink: OK
07/23 09:03:50 yS1 vgetty: queued event RESET_WATCHDOG at position
0002
07/23 09:03:50 yS1 Elsa MicroLink: _DIALUP: (2)
07/23 09:03:50 yS1 voice command: 'AT#VLS=4' -> 'OK'
07/23 09:03:50 yS1 vgetty: AT#VLS=4
07/23 09:03:50 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0002
07/23 09:03:50 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:03:50 yS1 Elsa MicroLink: AT#VLS=4
07/23 09:03:50 yS1 Elsa MicroLink: OK
07/23 09:03:50 yS1 voice command: 'ATA' -> 'VCON|+VCON'
07/23 09:03:50 yS1 vgetty: ATA
07/23 09:03:50 yS1 Elsa MicroLink: ATA
07/23 09:03:50 yS1 Elsa MicroLink: VCON
07/23 09:03:50 yS1 playing voice file
/usr/local/spool/voice/messages/comphere4.rmd
07/23 09:03:51 yS1 vgetty: raw modem data header found
07/23 09:03:51 yS1 vgetty: modem type Elsa found
07/23 09:03:51 yS1 vgetty: compression method 0x0004, speed 7200, bits
4
07/23 09:03:51 yS1 vgetty: queued event RESET_WATCHDOG at position
0003
07/23 09:03:51 yS1 voice command: 'AT#VBS=4' -> 'OK'
07/23 09:03:51 yS1 vgetty: AT#VBS=4
07/23 09:03:51 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0003
07/23 09:03:51 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:03:51 yS1 Elsa MicroLink: AT#VBS=4
07/23 09:03:51 yS1 Elsa MicroLink: OK
07/23 09:03:51 yS1 vgetty: queued event RESET_WATCHDOG at position
0004
07/23 09:03:51 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0004
07/23 09:03:51 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:03:51 yS1 voice command: 'AT\Q3' -> 'OK'
07/23 09:03:51 yS1 vgetty: AT\Q3
07/23 09:03:51 yS1 Elsa MicroLink: AT\Q3
07/23 09:03:51 yS1 Elsa MicroLink: OK
07/23 09:03:51 yS1 tio_set_flow_control( HARD XON_OUT )
07/23 09:03:51 yS1 voice command: 'AT#VTX' -> 'CONNECT'
07/23 09:03:51 yS1 vgetty: AT#VTX
07/23 09:03:51 yS1 Elsa MicroLink: AT#VTX
07/23 09:03:51 yS1 Elsa MicroLink: CONNECT
07/23 09:03:59 yS1 vgetty: <VOICE DATA 31055 bytes>
07/23 09:03:59 yS1 vgetty: queued event RESET_WATCHDOG at position
0005
07/23 09:03:59 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0005
07/23 09:03:59 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:03:59 yS1 vgetty: <STOP PLAY>
07/23 09:03:59 yS1 voice command: '' -> 'OK|VCON'
07/23 09:03:59 yS1 Elsa MicroLink: VCON
07/23 09:04:02 yS1 vgetty: queued event RESET_WATCHDOG at position
0006
07/23 09:04:02 yS1 voice command: 'AT#VTS=[933,0,15]' -> ''
07/23 09:04:02 yS1 vgetty: AT#VTS=[933,0,15]
07/23 09:04:02 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0006
07/23 09:04:02 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:04:02 yS1 Elsa MicroLink: AT#VTS=[933,0,15]
07/23 09:04:04 yS1 voice command: '' -> 'OK'
07/23 09:04:04 yS1 Elsa MicroLink: OK
07/23 09:04:04 yS1 recording voice file
/usr/local/spool/voice/incoming/va13200.rmd
07/23 09:04:04 yS1 vgetty: queued event RESET_WATCHDOG at position
0007
07/23 09:04:04 yS1 voice command: 'AT#VBS=4' -> 'OK'
07/23 09:04:04 yS1 vgetty: AT#VBS=4
07/23 09:04:04 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0007
07/23 09:04:04 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:04:04 yS1 Elsa MicroLink: AT#VBS=4
07/23 09:04:04 yS1 Elsa MicroLink: OK
07/23 09:04:04 yS1 vgetty: queued event RESET_WATCHDOG at position
0008
07/23 09:04:04 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0008
07/23 09:04:04 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:04:04 yS1 voice command: 'AT\Q3' -> 'OK'
07/23 09:04:04 yS1 vgetty: AT\Q3
07/23 09:04:04 yS1 Elsa MicroLink: AT\Q3
07/23 09:04:04 yS1 Elsa MicroLink: OK
07/23 09:04:04 yS1 tio_set_flow_control( HARD XON_IN )
07/23 09:04:04 yS1 voice command: 'AT#VRX' -> 'CONNECT'
07/23 09:04:04 yS1 vgetty: AT#VRX
07/23 09:04:04 yS1 Elsa MicroLink: AT#VRX
07/23 09:04:04 yS1 Elsa MicroLink: CONNECT
07/23 09:04:04 yS1 Elsa MicroLink: <DLE> <t>
07/23 09:04:04 yS1 vgetty: queued event TDD_DETECTED at position 0009
07/23 09:04:04 yS1 vgetty: unqueued event TDD_DETECTED at position
0009
07/23 09:04:04 yS1 vgetty: voice_handle_event got event TDD_DETECTED
with data <_>
07/23 09:04:04 yS1 vgetty: voice_handle_event got unknown event
TDD_DETECTED with data <_>
07/23 09:04:10 yS1 Elsa MicroLink: <DLE> <b>
07/23 09:04:10 yS1 vgetty: queued event BUSY_TONE at position 0010
07/23 09:04:10 yS1 vgetty: unqueued event BUSY_TONE at position 0010
07/23 09:04:10 yS1 vgetty: voice_handle_event got event BUSY_TONE
with data <_>
07/23 09:04:10 yS1 vgetty: <STOP RECORDING>
07/23 09:04:10 yS1 Elsa MicroLink: <VOICE DATA 19334 bytes>
07/23 09:04:10 yS1 Elsa MicroLink: <DLE> <ETX>
07/23 09:04:10 yS1 voice command: '' -> 'OK|VCON'
07/23 09:04:10 yS1 Elsa MicroLink: VCON
07/23 09:04:10 yS1 vgetty: queued event RESET_WATCHDOG at position
0011
07/23 09:04:10 yS1 Elsa MicroLink: _NO_DEV: (1)
07/23 09:04:10 yS1 voice command: 'AT#VLS=0' -> 'OK'
07/23 09:04:10 yS1 vgetty: AT#VLS=0
07/23 09:04:10 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0011
07/23 09:04:10 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:04:10 yS1 Elsa MicroLink: AT#VLS=0
07/23 09:04:10 yS1 Elsa MicroLink: OK
07/23 09:04:10 yS1 vgetty: leaving voice mode
07/23 09:04:10 yS1 voice command: 'AT#CLS=2' -> 'OK'
07/23 09:04:10 yS1 vgetty: AT#CLS=2
07/23 09:04:10 yS1 Elsa MicroLink: AT#CLS=2
07/23 09:04:11 yS1 Elsa MicroLink: OK
07/23 09:04:11 yS1 vgetty: Restoring signal handlers
07/23 09:04:11 yS1 closing voice modem device
07/23 09:04:11 yS1 removing lock file
07/23 09:04:11 ##### message keep, length=00:00:06, name='',
caller=none, dev=ttyS1, pid=13200
07/23 09:04:11 yS1 vgetty: creating message flag file
/usr/local/spool/voice/.flag
--
07/23 09:04:11 yS1 vgetty: experimental test release 0.8.1 / 25Mar98
07/23 09:04:11 yS1 mgetty: experimental test release 1.1.16-Jul05
07/23 09:04:11 yS1 vgetty.c compiled at Jul 22 1998, 22:33:37
07/23 09:04:11 yS1 user id: 0, parent pid: 1
07/23 09:04:11 yS1 reading configuration data for port 'ttyS1'
07/23 09:04:11 yS1 reading /etc/mgetty+sendfax/mgetty.config...
07/23 09:04:11 yS1 conf lib: read: 'debug 9'
07/23 09:04:11 yS1 conf lib: read: 'fax-id ++43-1-726 54 37'
07/23 09:04:11 yS1 conf lib: read: 'speed 115200'
07/23 09:04:11 yS1 conf lib: read: 'port-owner root'
07/23 09:04:11 yS1 conf lib: read: 'port-group uucp'
07/23 09:04:11 yS1 conf lib: read: 'port-mode 0664'
07/23 09:04:11 yS1 conf lib: read: 'fax-owner root'
07/23 09:04:11 yS1 conf lib: read: 'fax-group private'
07/23 09:04:11 yS1 conf lib: read: 'fax-mode 0660'
07/23 09:04:11 yS1 conf lib: read: 'port ttyS1'
07/23 09:04:11 yS1 section: port ttyS1, **found**
07/23 09:04:11 yS1 conf lib: read: 'debug 9'
07/23 09:04:11 yS1 conf lib: read: 'init-chat "" +++\dATH OK
"AT&F1S0=0&C1&D2S40=4" OK ATM0V1Q0T OK'
07/23 09:04:11 yS1 conf lib: read: 'speed 115200'
07/23 09:04:11 yS1 conf lib: read: 'rings 3'
07/23 09:04:11 yS1 conf lib: read: 'ignore-carrier no'
07/23 09:04:11 yS1 conf lib: read: 'notify martin'
07/23 09:04:11 yS1 conf lib: read: 'modem-type c2.0'
07/23 09:04:11 yS1 key: 'speed', type=0, flags=3, data=115200
07/23 09:04:11 yS1 key: 'switchbd', type=0, flags=1, data=0
07/23 09:04:11 yS1 key: 'direct', type=3, flags=1, data=FALSE
07/23 09:04:11 yS1 key: 'blocking', type=3, flags=1, data=FALSE
07/23 09:04:11 yS1 key: 'port-owner', type=1, flags=3, data=root
07/23 09:04:11 yS1 key: 'port-group', type=1, flags=3, data=uucp
07/23 09:04:11 yS1 key: 'port-mode', type=0, flags=3, data=436
07/23 09:04:11 yS1 key: 'toggle-dtr', type=3, flags=1, data=TRUE
07/23 09:04:11 yS1 key: 'toggle-dtr-waittime', type=0, flags=1,
data=500
07/23 09:04:11 yS1 key: 'data-only', type=3, flags=1, data=FALSE
07/23 09:04:11 yS1 key: 'fax-only', type=3, flags=1, data=FALSE
07/23 09:04:11 yS1 key: 'modem-type', type=1, flags=3, data=c2.0
07/23 09:04:11 yS1 key: 'modem-quirks', type=0, flags=0, data=(empty)
07/23 09:04:11 yS1 key: 'init-chat', type=2, flags=3, data= +++\dATH
OK AT&F1S0=0&C1&D2S40=4 OK ATM0V1Q0T OK
07/23 09:04:11 yS1 key: 'force-init-chat', type=2, flags=1, data=
\d\d\d\d+++\d\d\d
\dATQ0V1H0 OK
07/23 09:04:11 yS1 key: 'modem-check-time', type=0, flags=1, data=3600
07/23 09:04:11 yS1 key: 'rings', type=0, flags=3, data=3
07/23 09:04:11 yS1 key: 'msn-list', type=2, flags=0, data=(empty)
07/23 09:04:11 yS1 key: 'get-cnd-chat', type=2, flags=0, data=(empty)
07/23 09:04:11 yS1 key: 'cnd-program', type=1, flags=0, data=(empty)
07/23 09:04:11 yS1 key: 'answer-chat', type=2, flags=1, data= ATA
CONNECT \c
07/23 09:04:11 yS1 key: 'answer-chat-timeout', type=0, flags=1,
data=80
07/23 09:04:11 yS1 key: 'autobauding', type=3, flags=1, data=FALSE
07/23 09:04:11 yS1 key: 'ringback', type=3, flags=1, data=FALSE
07/23 09:04:11 yS1 key: 'ringback-time', type=0, flags=1, data=30
07/23 09:04:11 yS1 key: 'ignore-carrier', type=3, flags=3, data=FALSE
07/23 09:04:11 yS1 key: 'issue-file', type=1, flags=1, data=/etc/issue
07/23 09:04:11 yS1 key: 'prompt-waittime', type=0, flags=1, data=500
07/23 09:04:11 yS1 key: 'login-prompt', type=1, flags=1, data=@!login:
07/23 09:04:11 yS1 key: 'login-time', type=0, flags=1, data=240
07/23 09:04:11 yS1 key: 'fido-send-emsi', type=3, flags=1, data=TRUE
07/23 09:04:11 yS1 key: 'fax-id', type=1, flags=3, data=++43-1-726 54
37
07/23 09:04:11 yS1 key: 'fax-min-speed', type=0, flags=1, data=0
07/23 09:04:11 yS1 key: 'fax-max-speed', type=0, flags=1, data=14400
07/23 09:04:11 yS1 key: 'fax-server-file', type=1, flags=0,
data=(empty)
07/23 09:04:11 yS1 key: 'diskspace', type=0, flags=1, data=1024
07/23 09:04:11 yS1 key: 'notify', type=1, flags=3, data=martin
07/23 09:04:11 yS1 key: 'fax-owner', type=1, flags=3, data=root
07/23 09:04:11 yS1 key: 'fax-group', type=1, flags=3, data=private
07/23 09:04:11 yS1 key: 'fax-mode', type=0, flags=3, data=432
07/23 09:04:11 yS1 key: 'debug', type=0, flags=2, data=9
07/23 09:04:11 yS1 key: 'statistics-chat', type=2, flags=0,
data=(empty)
07/23 09:04:11 yS1 key: 'statistics-file', type=1, flags=0,
data=(empty)
07/23 09:04:11 yS1 key: 'gettydefs', type=1, flags=1, data=n
07/23 09:04:11 yS1 key: 'term', type=1, flags=0, data=(empty)
07/23 09:04:11 yS1 reading generic configuration from config file
/etc/mgetty+sendfax/voice.conf
07/23 09:04:11 yS1 reading /etc/mgetty+sendfax/voice.conf...
07/23 09:04:11 yS1 conf lib: read: 'part generic'
07/23 09:04:11 yS1 section: part generic, **found**
07/23 09:04:11 yS1 conf lib: read: 'voice_log_level 9'
07/23 09:04:11 yS1 conf lib: read: 'voice_dir /usr/local/spool/voice'
07/23 09:04:11 yS1 conf lib: read: 'phone_owner root'
07/23 09:04:11 yS1 conf lib: read: 'phone_group private'
07/23 09:04:11 yS1 conf lib: read: 'phone_mode 0660'
07/23 09:04:11 yS1 conf lib: read: 'message_flag_file .flag'
07/23 09:04:11 yS1 conf lib: read: 'receive_dir incoming'
07/23 09:04:11 yS1 conf lib: read: 'message_dir messages'
07/23 09:04:11 yS1 conf lib: read: 'message_list Index'
07/23 09:04:11 yS1 conf lib: read: 'backup_message standard.rmd'
07/23 09:04:11 yS1 conf lib: read: 'port_speed 115200'
07/23 09:04:11 yS1 conf lib: read: 'voice_shell /bin/sh'
07/23 09:04:11 yS1 conf lib: read: 'port_timeout 10'
07/23 09:04:11 yS1 conf lib: read: 'dial_timeout 90'
07/23 09:04:11 yS1 conf lib: read: 'command_delay 100'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_len 30'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_threshold 40'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_wait 7'
07/23 09:04:11 yS1 conf lib: read: 'ignore_fax_dle false'
07/23 09:04:11 yS1 conf lib: read: 'raw_data false'
07/23 09:04:11 yS1 conf lib: read: 'rec_compression 4'
07/23 09:04:11 yS1 conf lib: read: 'rec_speed 0'
07/23 09:04:11 yS1 conf lib: read: 'rec_silence_len 70'
07/23 09:04:11 yS1 conf lib: read: 'rec_silence_threshold 40'
07/23 09:04:11 yS1 conf lib: read: 'rec_remove_silence false'
07/23 09:04:11 yS1 conf lib: read: 'rec_max_len 300'
07/23 09:04:11 yS1 conf lib: read: 'rec_min_len 0'
07/23 09:04:11 yS1 conf lib: read: 'do_hard_flow true'
07/23 09:04:11 yS1 conf lib: read: 'beep_frequency 933'
07/23 09:04:11 yS1 conf lib: read: 'beep_length 1500'
07/23 09:04:11 yS1 conf lib: read: 'max_tries 3'
07/23 09:04:11 yS1 conf lib: read: 'retry_delay 5'
07/23 09:04:11 yS1 conf lib: read: 'watchdog_timeout 60'
07/23 09:04:11 yS1 conf lib: read: 'receive_gain -1'
07/23 09:04:11 yS1 conf lib: read: 'transmit_gain -1'
07/23 09:04:11 yS1 conf lib: read: 'enable_command_echo true'
07/23 09:04:11 yS1 conf lib: read: 'poll_interval 10'
07/23 09:04:11 yS1 conf lib: read: 'program vgetty'
07/23 09:04:11 yS1 found CT_KEYWORD program vgetty
07/23 09:04:11 yS1 conf lib: read: 'rings 3'
07/23 09:04:11 yS1 conf lib: read: 'answer_mode voice:fax:data'
07/23 09:04:11 yS1 conf lib: read: 'force_autodetect false'
07/23 09:04:11 yS1 conf lib: read: 'toll_saver_rings 0'
07/23 09:04:11 yS1 conf lib: read: 'rec_always_keep true'
07/23 09:04:11 yS1 conf lib: read: 'button_program '
07/23 09:04:11 yS1 conf lib: read: 'call_program '
07/23 09:04:11 yS1 conf lib: read: 'dtmf_program dtmf.sh'
07/23 09:04:11 yS1 conf lib: read: 'message_program '
07/23 09:04:11 yS1 conf lib: read: 'do_message_light false'
07/23 09:04:11 yS1 conf lib: read: 'program vm'
07/23 09:04:11 yS1 conf lib: read: 'voice_devices ttyS1'
07/23 09:04:11 yS1 conf lib: read: 'dialout_timeout 90'
07/23 09:04:11 yS1 conf lib: read: 'program pvf'
07/23 09:04:11 yS1 conf lib: read: 'port ttyS1'
07/23 09:04:11 yS1 conf lib: read: 'rings 3'
07/23 09:04:11 yS1 conf lib: read: 'ring_type virtual'
07/23 09:04:11 yS1 conf lib: read: 'answer_mode fax:data'
07/23 09:04:11 yS1 conf lib: read: 'ring_type ring'
07/23 09:04:11 yS1 conf lib: read: 'ring_type ring1'
07/23 09:04:11 yS1 key: 'part', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'program', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'port', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'ring_type', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'voice_log_level', type=0, flags=3, data=9
07/23 09:04:11 yS1 key: 'voice_shell', type=1, flags=3, data=/bin/sh
07/23 09:04:11 yS1 key: 'port_speed', type=0, flags=3, data=115200
07/23 09:04:11 yS1 key: 'port_timeout', type=0, flags=3, data=10
07/23 09:04:11 yS1 key: 'dial_timeout', type=0, flags=3, data=90
07/23 09:04:11 yS1 key: 'command_delay', type=0, flags=3, data=100
07/23 09:04:11 yS1 key: 'dtmf_len', type=0, flags=3, data=30
07/23 09:04:11 yS1 key: 'dtmf_threshold', type=0, flags=3, data=40
07/23 09:04:11 yS1 key: 'dtmf_wait', type=0, flags=3, data=7
07/23 09:04:11 yS1 key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
07/23 09:04:11 yS1 key: 'raw_data', type=3, flags=3, data=FALSE
07/23 09:04:11 yS1 key: 'rec_compression', type=0, flags=3, data=4
07/23 09:04:11 yS1 key: 'rec_speed', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'rec_silence_len', type=0, flags=3, data=70
07/23 09:04:11 yS1 key: 'rec_silence_threshold', type=0, flags=3,
data=40
07/23 09:04:11 yS1 key: 'rec_remove_silence', type=3, flags=3,
data=FALSE
07/23 09:04:11 yS1 key: 'rec_max_len', type=0, flags=3, data=300
07/23 09:04:11 yS1 key: 'rec_min_len', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'do_hard_flow', type=3, flags=3, data=TRUE
07/23 09:04:11 yS1 key: 'force_autodetect', type=3, flags=1,
data=FALSE
07/23 09:04:11 yS1 key: 'watchdog_timeout', type=0, flags=3, data=60
07/23 09:04:11 yS1 key: 'receive_gain', type=0, flags=3, data=-1
07/23 09:04:11 yS1 key: 'transmit_gain', type=0, flags=3, data=-1
07/23 09:04:11 yS1 key: 'enable_command_echo', type=3, flags=3,
data=TRUE
07/23 09:04:11 yS1 key: 'poll_interval', type=0, flags=3, data=10
07/23 09:04:11 yS1 key: 'rings', type=1, flags=1, data=3
07/23 09:04:11 yS1 key: 'answer_mode', type=1, flags=1,
data=voice:fax:data
07/23 09:04:11 yS1 key: 'toll_saver_rings', type=0, flags=1, data=0
07/23 09:04:11 yS1 key: 'rec_always_keep', type=3, flags=1, data=TRUE
07/23 09:04:11 yS1 key: 'voice_dir', type=1, flags=3,
data=/usr/local/spool/voice
07/23 09:04:11 yS1 key: 'phone_owner', type=1, flags=3, data=root
07/23 09:04:11 yS1 key: 'phone_group', type=1, flags=3, data=private
07/23 09:04:11 yS1 key: 'phone_mode', type=0, flags=3, data=432
07/23 09:04:11 yS1 key: 'message_flag_file', type=1, flags=3,
data=.flag
07/23 09:04:11 yS1 key: 'receive_dir', type=1, flags=3, data=incoming
07/23 09:04:11 yS1 key: 'message_dir', type=1, flags=3, data=messages
07/23 09:04:11 yS1 key: 'message_list', type=1, flags=3, data=Index
07/23 09:04:11 yS1 key: 'backup_message', type=1, flags=3,
data=standard.rmd
07/23 09:04:11 yS1 key: 'button_program', type=1, flags=1, data=
07/23 09:04:11 yS1 key: 'call_program', type=1, flags=1, data=
07/23 09:04:11 yS1 key: 'dtmf_program', type=1, flags=1, data=dtmf.sh
07/23 09:04:11 yS1 key: 'message_program', type=1, flags=1, data=
07/23 09:04:11 yS1 key: 'do_message_light', type=3, flags=1,
data=FALSE
07/23 09:04:11 yS1 key: 'beep_frequency', type=0, flags=3, data=933
07/23 09:04:11 yS1 key: 'beep_length', type=0, flags=3, data=1500
07/23 09:04:11 yS1 key: 'max_tries', type=0, flags=3, data=3
07/23 09:04:11 yS1 key: 'retry_delay', type=0, flags=3, data=5
07/23 09:04:11 yS1 key: 'dialout_timeout', type=0, flags=1, data=90
07/23 09:04:11 yS1 key: 'voice_devices', type=1, flags=1, data=
07/23 09:04:11 yS1 reading program vgetty configuration from config
file /etc/mgetty+sendfax/voice.conf
07/23 09:04:11 yS1 reading /etc/mgetty+sendfax/voice.conf...
07/23 09:04:11 yS1 conf lib: read: 'part generic'
07/23 09:04:11 yS1 found CT_KEYWORD part generic
07/23 09:04:11 yS1 conf lib: read: 'voice_log_level 9'
07/23 09:04:11 yS1 conf lib: read: 'voice_dir /usr/local/spool/voice'
07/23 09:04:11 yS1 conf lib: read: 'phone_owner root'
07/23 09:04:11 yS1 conf lib: read: 'phone_group private'
07/23 09:04:11 yS1 conf lib: read: 'phone_mode 0660'
07/23 09:04:11 yS1 conf lib: read: 'message_flag_file .flag'
07/23 09:04:11 yS1 conf lib: read: 'receive_dir incoming'
07/23 09:04:11 yS1 conf lib: read: 'message_dir messages'
07/23 09:04:11 yS1 conf lib: read: 'message_list Index'
07/23 09:04:11 yS1 conf lib: read: 'backup_message standard.rmd'
07/23 09:04:11 yS1 conf lib: read: 'port_speed 115200'
07/23 09:04:11 yS1 conf lib: read: 'voice_shell /bin/sh'
07/23 09:04:11 yS1 conf lib: read: 'port_timeout 10'
07/23 09:04:11 yS1 conf lib: read: 'dial_timeout 90'
07/23 09:04:11 yS1 conf lib: read: 'command_delay 100'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_len 30'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_threshold 40'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_wait 7'
07/23 09:04:11 yS1 conf lib: read: 'ignore_fax_dle false'
07/23 09:04:11 yS1 conf lib: read: 'raw_data false'
07/23 09:04:11 yS1 conf lib: read: 'rec_compression 4'
07/23 09:04:11 yS1 conf lib: read: 'rec_speed 0'
07/23 09:04:11 yS1 conf lib: read: 'rec_silence_len 70'
07/23 09:04:11 yS1 conf lib: read: 'rec_silence_threshold 40'
07/23 09:04:11 yS1 conf lib: read: 'rec_remove_silence false'
07/23 09:04:11 yS1 conf lib: read: 'rec_max_len 300'
07/23 09:04:11 yS1 conf lib: read: 'rec_min_len 0'
07/23 09:04:11 yS1 conf lib: read: 'do_hard_flow true'
07/23 09:04:11 yS1 conf lib: read: 'beep_frequency 933'
07/23 09:04:11 yS1 conf lib: read: 'beep_length 1500'
07/23 09:04:11 yS1 conf lib: read: 'max_tries 3'
07/23 09:04:11 yS1 conf lib: read: 'retry_delay 5'
07/23 09:04:11 yS1 conf lib: read: 'watchdog_timeout 60'
07/23 09:04:11 yS1 conf lib: read: 'receive_gain -1'
07/23 09:04:11 yS1 conf lib: read: 'transmit_gain -1'
07/23 09:04:11 yS1 conf lib: read: 'enable_command_echo true'
07/23 09:04:11 yS1 conf lib: read: 'poll_interval 10'
07/23 09:04:11 yS1 conf lib: read: 'program vgetty'
07/23 09:04:11 yS1 section: program vgetty, **found**
07/23 09:04:11 yS1 conf lib: read: 'rings 3'
07/23 09:04:11 yS1 conf lib: read: 'answer_mode voice:fax:data'
07/23 09:04:11 yS1 conf lib: read: 'force_autodetect false'
07/23 09:04:11 yS1 conf lib: read: 'toll_saver_rings 0'
07/23 09:04:11 yS1 conf lib: read: 'rec_always_keep true'
07/23 09:04:11 yS1 conf lib: read: 'button_program '
07/23 09:04:11 yS1 conf lib: read: 'call_program '
07/23 09:04:11 yS1 conf lib: read: 'dtmf_program dtmf.sh'
07/23 09:04:11 yS1 conf lib: read: 'message_program '
07/23 09:04:11 yS1 conf lib: read: 'do_message_light false'
07/23 09:04:11 yS1 conf lib: read: 'program vm'
07/23 09:04:11 yS1 section: program vm, ignore
07/23 09:04:11 yS1 conf lib: read: 'voice_devices ttyS1'
07/23 09:04:11 yS1 conf lib: read: 'dialout_timeout 90'
07/23 09:04:11 yS1 conf lib: read: 'program pvf'
07/23 09:04:11 yS1 section: program pvf, ignore
07/23 09:04:11 yS1 conf lib: read: 'port ttyS1'
07/23 09:04:11 yS1 conf lib: read: 'rings 3'
07/23 09:04:11 yS1 conf lib: read: 'ring_type virtual'
07/23 09:04:11 yS1 conf lib: read: 'answer_mode fax:data'
07/23 09:04:11 yS1 conf lib: read: 'ring_type ring'
07/23 09:04:11 yS1 conf lib: read: 'ring_type ring1'
07/23 09:04:11 yS1 key: 'part', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'program', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'port', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'ring_type', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'voice_log_level', type=0, flags=3, data=9
07/23 09:04:11 yS1 key: 'voice_shell', type=1, flags=3, data=/bin/sh
07/23 09:04:11 yS1 key: 'port_speed', type=0, flags=3, data=115200
07/23 09:04:11 yS1 key: 'port_timeout', type=0, flags=3, data=10
07/23 09:04:11 yS1 key: 'dial_timeout', type=0, flags=3, data=90
07/23 09:04:11 yS1 key: 'command_delay', type=0, flags=3, data=100
07/23 09:04:11 yS1 key: 'dtmf_len', type=0, flags=3, data=30
07/23 09:04:11 yS1 key: 'dtmf_threshold', type=0, flags=3, data=40
07/23 09:04:11 yS1 key: 'dtmf_wait', type=0, flags=3, data=7
07/23 09:04:11 yS1 key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
07/23 09:04:11 yS1 key: 'raw_data', type=3, flags=3, data=FALSE
07/23 09:04:11 yS1 key: 'rec_compression', type=0, flags=3, data=4
07/23 09:04:11 yS1 key: 'rec_speed', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'rec_silence_len', type=0, flags=3, data=70
07/23 09:04:11 yS1 key: 'rec_silence_threshold', type=0, flags=3,
data=40
07/23 09:04:11 yS1 key: 'rec_remove_silence', type=3, flags=3,
data=FALSE
07/23 09:04:11 yS1 key: 'rec_max_len', type=0, flags=3, data=300
07/23 09:04:11 yS1 key: 'rec_min_len', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'do_hard_flow', type=3, flags=3, data=TRUE
07/23 09:04:11 yS1 key: 'force_autodetect', type=3, flags=3,
data=FALSE
07/23 09:04:11 yS1 key: 'watchdog_timeout', type=0, flags=3, data=60
07/23 09:04:11 yS1 key: 'receive_gain', type=0, flags=3, data=-1
07/23 09:04:11 yS1 key: 'transmit_gain', type=0, flags=3, data=-1
07/23 09:04:11 yS1 key: 'enable_command_echo', type=3, flags=3,
data=TRUE
07/23 09:04:11 yS1 key: 'poll_interval', type=0, flags=3, data=10
07/23 09:04:11 yS1 key: 'rings', type=1, flags=3, data=3
07/23 09:04:11 yS1 key: 'answer_mode', type=1, flags=3,
data=voice:fax:data
07/23 09:04:11 yS1 key: 'toll_saver_rings', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'rec_always_keep', type=3, flags=3, data=TRUE
07/23 09:04:11 yS1 key: 'voice_dir', type=1, flags=3,
data=/usr/local/spool/voice
07/23 09:04:11 yS1 key: 'phone_owner', type=1, flags=3, data=root
07/23 09:04:11 yS1 key: 'phone_group', type=1, flags=3, data=private
07/23 09:04:11 yS1 key: 'phone_mode', type=0, flags=3, data=432
07/23 09:04:11 yS1 key: 'message_flag_file', type=1, flags=3,
data=.flag
07/23 09:04:11 yS1 key: 'receive_dir', type=1, flags=3, data=incoming
07/23 09:04:11 yS1 key: 'message_dir', type=1, flags=3, data=messages
07/23 09:04:11 yS1 key: 'message_list', type=1, flags=3, data=Index
07/23 09:04:11 yS1 key: 'backup_message', type=1, flags=3,
data=standard.rmd
07/23 09:04:11 yS1 key: 'button_program', type=1, flags=3, data=
07/23 09:04:11 yS1 key: 'call_program', type=1, flags=3, data=
07/23 09:04:11 yS1 key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
07/23 09:04:11 yS1 key: 'message_program', type=1, flags=3, data=
07/23 09:04:11 yS1 key: 'do_message_light', type=3, flags=3,
data=FALSE
07/23 09:04:11 yS1 key: 'beep_frequency', type=0, flags=3, data=933
07/23 09:04:11 yS1 key: 'beep_length', type=0, flags=3, data=1500
07/23 09:04:11 yS1 key: 'max_tries', type=0, flags=3, data=3
07/23 09:04:11 yS1 key: 'retry_delay', type=0, flags=3, data=5
07/23 09:04:11 yS1 key: 'dialout_timeout', type=0, flags=1, data=90
07/23 09:04:11 yS1 key: 'voice_devices', type=1, flags=1, data=
07/23 09:04:11 yS1 reading port ttyS1 configuration from config file
/etc/mgetty+sendfax/voice.conf
07/23 09:04:11 yS1 reading /etc/mgetty+sendfax/voice.conf...
07/23 09:04:11 yS1 conf lib: read: 'part generic'
07/23 09:04:11 yS1 found CT_KEYWORD part generic
07/23 09:04:11 yS1 conf lib: read: 'voice_log_level 9'
07/23 09:04:11 yS1 conf lib: read: 'voice_dir /usr/local/spool/voice'
07/23 09:04:11 yS1 conf lib: read: 'phone_owner root'
07/23 09:04:11 yS1 conf lib: read: 'phone_group private'
07/23 09:04:11 yS1 conf lib: read: 'phone_mode 0660'
07/23 09:04:11 yS1 conf lib: read: 'message_flag_file .flag'
07/23 09:04:11 yS1 conf lib: read: 'receive_dir incoming'
07/23 09:04:11 yS1 conf lib: read: 'message_dir messages'
07/23 09:04:11 yS1 conf lib: read: 'message_list Index'
07/23 09:04:11 yS1 conf lib: read: 'backup_message standard.rmd'
07/23 09:04:11 yS1 conf lib: read: 'port_speed 115200'
07/23 09:04:11 yS1 conf lib: read: 'voice_shell /bin/sh'
07/23 09:04:11 yS1 conf lib: read: 'port_timeout 10'
07/23 09:04:11 yS1 conf lib: read: 'dial_timeout 90'
07/23 09:04:11 yS1 conf lib: read: 'command_delay 100'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_len 30'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_threshold 40'
07/23 09:04:11 yS1 conf lib: read: 'dtmf_wait 7'
07/23 09:04:11 yS1 conf lib: read: 'ignore_fax_dle false'
07/23 09:04:11 yS1 conf lib: read: 'raw_data false'
07/23 09:04:11 yS1 conf lib: read: 'rec_compression 4'
07/23 09:04:11 yS1 conf lib: read: 'rec_speed 0'
07/23 09:04:11 yS1 conf lib: read: 'rec_silence_len 70'
07/23 09:04:11 yS1 conf lib: read: 'rec_silence_threshold 40'
07/23 09:04:11 yS1 conf lib: read: 'rec_remove_silence false'
07/23 09:04:11 yS1 conf lib: read: 'rec_max_len 300'
07/23 09:04:11 yS1 conf lib: read: 'rec_min_len 0'
07/23 09:04:11 yS1 conf lib: read: 'do_hard_flow true'
07/23 09:04:11 yS1 conf lib: read: 'beep_frequency 933'
07/23 09:04:11 yS1 conf lib: read: 'beep_length 1500'
07/23 09:04:11 yS1 conf lib: read: 'max_tries 3'
07/23 09:04:11 yS1 conf lib: read: 'retry_delay 5'
07/23 09:04:11 yS1 conf lib: read: 'watchdog_timeout 60'
07/23 09:04:11 yS1 conf lib: read: 'receive_gain -1'
07/23 09:04:11 yS1 conf lib: read: 'transmit_gain -1'
07/23 09:04:11 yS1 conf lib: read: 'enable_command_echo true'
07/23 09:04:11 yS1 conf lib: read: 'poll_interval 10'
07/23 09:04:11 yS1 conf lib: read: 'program vgetty'
07/23 09:04:11 yS1 conf lib: read: 'rings 3'
07/23 09:04:11 yS1 conf lib: read: 'answer_mode voice:fax:data'
07/23 09:04:11 yS1 conf lib: read: 'force_autodetect false'
07/23 09:04:11 yS1 conf lib: read: 'toll_saver_rings 0'
07/23 09:04:11 yS1 conf lib: read: 'rec_always_keep true'
07/23 09:04:11 yS1 conf lib: read: 'button_program '
07/23 09:04:11 yS1 conf lib: read: 'call_program '
07/23 09:04:11 yS1 conf lib: read: 'dtmf_program dtmf.sh'
07/23 09:04:11 yS1 conf lib: read: 'message_program '
07/23 09:04:11 yS1 conf lib: read: 'do_message_light false'
07/23 09:04:11 yS1 conf lib: read: 'program vm'
07/23 09:04:11 yS1 conf lib: read: 'voice_devices ttyS1'
07/23 09:04:11 yS1 conf lib: read: 'dialout_timeout 90'
07/23 09:04:11 yS1 conf lib: read: 'program pvf'
07/23 09:04:11 yS1 conf lib: read: 'port ttyS1'
07/23 09:04:11 yS1 section: port ttyS1, **found**
07/23 09:04:11 yS1 conf lib: read: 'rings 3'
07/23 09:04:11 yS1 conf lib: read: 'ring_type virtual'
07/23 09:04:11 yS1 found CT_KEYWORD ring_type virtual
07/23 09:04:11 yS1 conf lib: read: 'answer_mode fax:data'
07/23 09:04:11 yS1 conf lib: read: 'ring_type ring'
07/23 09:04:11 yS1 conf lib: read: 'ring_type ring1'
07/23 09:04:11 yS1 key: 'part', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'program', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'port', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'ring_type', type=6, flags=4, data=(ignored)
07/23 09:04:11 yS1 key: 'voice_log_level', type=0, flags=3, data=9
07/23 09:04:11 yS1 key: 'voice_shell', type=1, flags=3, data=/bin/sh
07/23 09:04:11 yS1 key: 'port_speed', type=0, flags=3, data=115200
07/23 09:04:11 yS1 key: 'port_timeout', type=0, flags=3, data=10
07/23 09:04:11 yS1 key: 'dial_timeout', type=0, flags=3, data=90
07/23 09:04:11 yS1 key: 'command_delay', type=0, flags=3, data=100
07/23 09:04:11 yS1 key: 'dtmf_len', type=0, flags=3, data=30
07/23 09:04:11 yS1 key: 'dtmf_threshold', type=0, flags=3, data=40
07/23 09:04:11 yS1 key: 'dtmf_wait', type=0, flags=3, data=7
07/23 09:04:11 yS1 key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
07/23 09:04:11 yS1 key: 'raw_data', type=3, flags=3, data=FALSE
07/23 09:04:11 yS1 key: 'rec_compression', type=0, flags=3, data=4
07/23 09:04:11 yS1 key: 'rec_speed', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'rec_silence_len', type=0, flags=3, data=70
07/23 09:04:11 yS1 key: 'rec_silence_threshold', type=0, flags=3,
data=40
07/23 09:04:11 yS1 key: 'rec_remove_silence', type=3, flags=3,
data=FALSE
07/23 09:04:11 yS1 key: 'rec_max_len', type=0, flags=3, data=300
07/23 09:04:11 yS1 key: 'rec_min_len', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'do_hard_flow', type=3, flags=3, data=TRUE
07/23 09:04:11 yS1 key: 'force_autodetect', type=3, flags=3,
data=FALSE
07/23 09:04:11 yS1 key: 'watchdog_timeout', type=0, flags=3, data=60
07/23 09:04:11 yS1 key: 'receive_gain', type=0, flags=3, data=-1
07/23 09:04:11 yS1 key: 'transmit_gain', type=0, flags=3, data=-1
07/23 09:04:11 yS1 key: 'enable_command_echo', type=3, flags=3,
data=TRUE
07/23 09:04:11 yS1 key: 'poll_interval', type=0, flags=3, data=10
07/23 09:04:11 yS1 key: 'rings', type=1, flags=3, data=3
07/23 09:04:11 yS1 key: 'answer_mode', type=1, flags=3,
data=voice:fax:data
07/23 09:04:11 yS1 key: 'toll_saver_rings', type=0, flags=3, data=0
07/23 09:04:11 yS1 key: 'rec_always_keep', type=3, flags=3, data=TRUE
07/23 09:04:11 yS1 key: 'voice_dir', type=1, flags=3,
data=/usr/local/spool/voice
07/23 09:04:11 yS1 key: 'phone_owner', type=1, flags=3, data=root
07/23 09:04:11 yS1 key: 'phone_group', type=1, flags=3, data=private
07/23 09:04:11 yS1 key: 'phone_mode', type=0, flags=3, data=432
07/23 09:04:11 yS1 key: 'message_flag_file', type=1, flags=3,
data=.flag
07/23 09:04:11 yS1 key: 'receive_dir', type=1, flags=3, data=incoming
07/23 09:04:11 yS1 key: 'message_dir', type=1, flags=3, data=messages
07/23 09:04:11 yS1 key: 'message_list', type=1, flags=3, data=Index
07/23 09:04:11 yS1 key: 'backup_message', type=1, flags=3,
data=standard.rmd
07/23 09:04:11 yS1 key: 'button_program', type=1, flags=3, data=
07/23 09:04:11 yS1 key: 'call_program', type=1, flags=3, data=
07/23 09:04:11 yS1 key: 'dtmf_program', type=1, flags=3, data=dtmf.sh
07/23 09:04:11 yS1 key: 'message_program', type=1, flags=3, data=
07/23 09:04:11 yS1 key: 'do_message_light', type=3, flags=3,
data=FALSE
07/23 09:04:11 yS1 key: 'beep_frequency', type=0, flags=3, data=933
07/23 09:04:11 yS1 key: 'beep_length', type=0, flags=3, data=1500
07/23 09:04:11 yS1 key: 'max_tries', type=0, flags=3, data=3
07/23 09:04:11 yS1 key: 'retry_delay', type=0, flags=3, data=5
07/23 09:04:11 yS1 key: 'dialout_timeout', type=0, flags=1, data=90
07/23 09:04:11 yS1 key: 'voice_devices', type=1, flags=1, data=
07/23 09:04:11 yS1 check for lockfiles
07/23 09:04:11 yS1 checklock: stat failed, no file
07/23 09:04:11 yS1 locking the line
07/23 09:04:11 yS1 makelock(ttyS1) called
07/23 09:04:11 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
07/23 09:04:11 yS1 lock made
07/23 09:04:12 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR
07/23 09:04:12 yS1 lowering DTR to reset Modem
07/23 09:04:12 yS1 tss: set speed to 115200 (10002)
07/23 09:04:12 yS1 tio_set_flow_control( HARD )
07/23 09:04:12 yS1 waiting for line to clear (VTIME), read:
[e0][e0][00][00][e0][00][e0][00][e0][e0][e0][00][e0][e0][e0][00][00][e0][00]
07/23 09:04:12 yS1 send: +++\dATH[0d]
07/23 09:04:13 yS1 waiting for ``OK''
07/23 09:04:13 yS1 got: ATH[0d]
07/23 09:04:13 yS1 CND: ATH[0d][0a]OK ** found **
07/23 09:04:13 yS1 send: AT&F1S0=0&C1&D2S40=4[0d]
07/23 09:04:13 yS1 waiting for ``OK''
07/23 09:04:13 yS1 got: [0d]
07/23 09:04:13 yS1 CND: OK[0a]AT&F1S0=0&C1&D2S40=4[0d]
07/23 09:04:13 yS1 CND: AT&F1S0=0&C1&D2S40=4[0d][0a]OK ** found **
07/23 09:04:13 yS1 send: ATM0V1Q0T[0d]
07/23 09:04:13 yS1 waiting for ``OK''
07/23 09:04:13 yS1 got: [0d]
07/23 09:04:13 yS1 CND: OK[0a]ATM0V1Q0T[0d]
07/23 09:04:13 yS1 CND: ATM0V1Q0T[0d][0a]OK ** found **
07/23 09:04:13 yS1 mdm_send: 'AT+FCLASS=2.0'
07/23 09:04:13 yS1 got:[0d][0a]AT+FCLASS=2.0[0d]
07/23 09:04:13 yS1 mdm_command: string 'AT+FCLASS=2.0'
07/23 09:04:13 yS1 got:[0d][0a]OK[0d]
07/23 09:04:13 yS1 mdm_command: string 'OK' -> OK
07/23 09:04:13 yS1 mdm_send: 'AT+FAA=1;+FCR=1'
07/23 09:04:13 yS1 got:[0a]AT+FAA=1;+FCR=1[0d]
07/23 09:04:13 yS1 mdm_command: string 'AT+FAA=1;+FCR=1'
07/23 09:04:13 yS1 got:[0d][0a]OK[0d]
07/23 09:04:13 yS1 mdm_command: string 'OK' -> OK
07/23 09:04:13 yS1 mdm_send: 'AT+FBO=1'
07/23 09:04:13 yS1 got:[0a]AT+FBO=1[0d]
07/23 09:04:13 yS1 mdm_command: string 'AT+FBO=1'
07/23 09:04:13 yS1 got:[0d][0a]OK[0d]
07/23 09:04:13 yS1 mdm_command: string 'OK' -> OK
07/23 09:04:13 yS1 mdm_send: 'AT+FNR=1,1,1,0'
07/23 09:04:13 yS1 got:[0a]AT+FNR=1,1,1,0[0d]
07/23 09:04:13 yS1 mdm_command: string 'AT+FNR=1,1,1,0'
07/23 09:04:13 yS1 got:[0d][0a]OK[0d]
07/23 09:04:13 yS1 mdm_command: string 'OK' -> OK
07/23 09:04:13 yS1 mdm_send: 'AT+FLI="++43-1-726 54 37"'
07/23 09:04:13 yS1 got:[0a]AT+FLI="++43-1-726 54 37"[0d]
07/23 09:04:13 yS1 mdm_command: string 'AT+FLI="++43-1-726 54 37"'
07/23 09:04:13 yS1 got:[0d][0a]OK[0d]
07/23 09:04:13 yS1 mdm_command: string 'OK' -> OK
07/23 09:04:13 yS1 mdm_send: 'AT+FCC=1,5,0,2,0,0,0,0'
07/23 09:04:13 yS1 got:[0a]AT+FCC=1,5,0,2,0,0,0,0[0d]
07/23 09:04:14 yS1 mdm_command: string 'AT+FCC=1,5,0,2,0,0,0,0'
07/23 09:04:14 yS1 got:[0d][0a]OK[0d]
07/23 09:04:14 yS1 mdm_command: string 'OK' -> OK
07/23 09:04:14 yS1 tss: set speed to 115200 (10002)
07/23 09:04:14 yS1 tio_set_flow_control( HARD )
07/23 09:04:14 yS1 detecting voice modem type
07/23 09:04:14 yS1 vgetty: ATE1
07/23 09:04:14 yS1 voice command: '' -> 'OK|ATE1'
07/23 09:04:14 yS1 serial port: ATE1
07/23 09:04:14 yS1 serial port: OK
07/23 09:04:14 yS1 voice command: 'ATI' -> ''
07/23 09:04:14 yS1 vgetty: ATI
07/23 09:04:14 yS1 serial port: ATI
07/23 09:04:14 yS1 serial port: 282
07/23 09:04:14 yS1 Elsa MicroLink: OK
07/23 09:04:14 yS1 Elsa MicroLink detected
07/23 09:04:14 yS1 vgetty: entering voice mode
07/23 09:04:14 yS1 vgetty: Installing signal handlers
07/23 09:04:14 yS1 voice command: 'AT#CLS?' -> ''
07/23 09:04:14 yS1 vgetty: AT#CLS?
07/23 09:04:14 yS1 Elsa MicroLink: AT#CLS?
07/23 09:04:14 yS1 Elsa MicroLink: 2
07/23 09:04:14 yS1 voice command: '' -> 'OK'
07/23 09:04:14 yS1 Elsa MicroLink: OK
07/23 09:04:14 yS1 voice command: 'AT#CLS=8' -> 'OK'
07/23 09:04:14 yS1 vgetty: AT#CLS=8
07/23 09:04:14 yS1 Elsa MicroLink: AT#CLS=8
07/23 09:04:14 yS1 Elsa MicroLink: OK
07/23 09:04:14 yS1 vgetty: queued event RESET_WATCHDOG at position
0000
07/23 09:04:14 yS1 initializing Elsa voice modem
07/23 09:04:14 yS1 voice command: 'AT#VSP=70' -> 'OK'
07/23 09:04:15 yS1 vgetty: AT#VSP=70
07/23 09:04:15 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0000
07/23 09:04:15 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:04:15 yS1 Elsa MicroLink: AT#VSP=70
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'AT#VSD=0' -> 'OK'
07/23 09:04:15 yS1 vgetty: AT#VSD=0
07/23 09:04:15 yS1 Elsa MicroLink: AT#VSD=0
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'AT#VBS=4' -> 'OK'
07/23 09:04:15 yS1 vgetty: AT#VBS=4
07/23 09:04:15 yS1 Elsa MicroLink: AT#VBS=4
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'AT#BDR=16' -> 'OK'
07/23 09:04:15 yS1 vgetty: AT#BDR=16
07/23 09:04:15 yS1 Elsa MicroLink: AT#BDR=16
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'AT#VTD=3F,3F,3F' -> 'OK'
07/23 09:04:15 yS1 vgetty: AT#VTD=3F,3F,3F
07/23 09:04:15 yS1 Elsa MicroLink: AT#VTD=3F,3F,3F
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'AT#VSS=1' -> 'OK'
07/23 09:04:15 yS1 vgetty: AT#VSS=1
07/23 09:04:15 yS1 Elsa MicroLink: AT#VSS=1
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'ATS30=60' -> 'OK'
07/23 09:04:15 yS1 vgetty: ATS30=60
07/23 09:04:15 yS1 Elsa MicroLink: ATS30=60
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'AT#VGT=191' -> 'OK'
07/23 09:04:15 yS1 vgetty: AT#VGT=191
07/23 09:04:15 yS1 Elsa MicroLink: AT#VGT=191
07/23 09:04:15 yS1 Elsa MicroLink: OK
07/23 09:04:15 yS1 voice command: 'AT#VGR=191' -> 'OK'
07/23 09:04:16 yS1 vgetty: AT#VGR=191
07/23 09:04:16 yS1 Elsa MicroLink: AT#VGR=191
07/23 09:04:16 yS1 Elsa MicroLink: OK
07/23 09:04:16 yS1 vgetty: queued event RESET_WATCHDOG at position
0001
07/23 09:04:16 yS1 Elsa MicroLink: _DIALUP: (2)
07/23 09:04:16 yS1 voice command: 'AT#VLS=4' -> 'OK'
07/23 09:04:16 yS1 vgetty: AT#VLS=4
07/23 09:04:16 yS1 vgetty: unqueued event RESET_WATCHDOG at position
0001
07/23 09:04:16 yS1 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <_>
07/23 09:04:16 yS1 Elsa MicroLink: AT#VLS=4
07/23 09:04:16 yS1 Elsa MicroLink: OK
07/23 09:04:16 yS1 voice command: 'AT\Q3' -> 'OK'
07/23 09:04:16 yS1 vgetty: AT\Q3
07/23 09:04:16 yS1 Elsa MicroLink: AT\Q3
07/23 09:04:16 yS1 Elsa MicroLink: OK
07/23 09:04:16 yS1 tio_set_flow_control( HARD )
07/23 09:04:16 yS1 vgetty: leaving voice mode
07/23 09:04:16 yS1 voice command: 'AT#CLS=2' -> 'OK'
07/23 09:04:16 yS1 vgetty: AT#CLS=2
07/23 09:04:16 yS1 Elsa MicroLink: AT#CLS=2
07/23 09:04:16 yS1 Elsa MicroLink: OK
07/23 09:04:16 yS1 vgetty: Restoring signal handlers
07/23 09:04:16 yS1 waiting for line to clear (VTIME), read:
07/23 09:04:16 yS1 removing lock file
07/23 09:04:16 yS1 waiting...
07/23 09:52:14 yS1 select returned 1
07/23 09:52:14 yS1 checking lockfiles, locking the line
07/23 09:52:14 yS1 makelock(ttyS1) called
07/23 09:52:14 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
07/23 09:52:14 yS1 lock made
07/23 09:52:14 yS1 vgetty: number of rings (3) was set directly
07/23 09:52:14 yS1 vgetty: decremented number of rings (3) by 0
07/23 09:52:14 yS1 wfr: waiting for ``RING''
07/23 09:52:14 yS1 got:
[0a][e0][e0][00][00][e0][00][00][00][e0][e0][e0][00][00][e0][00][00][e0][e0][00][e0][e0][e0][00][00][e0][00][e0][e0][00][00][e0][00][00][00][e0][e0][e0][00][00][e0][00][00][e0][e0][00][e0][e0][e0][00][00][e0][00]
07/23 09:52:24 yS1 mdm_read_byte: read returned -1: Interrupted system
call
07/23 09:52:24 yS1 wfr: timeout waiting for RING
07/23 09:52:24 yS1 wfr: rc=-1, drn=0
07/23 09:52:24 yS1 huh? Junk on the line?
07/23 09:52:24 yS1 removing lock file
--
07/23 09:52:24 yS1 vgetty: experimental test release 0.8.1 / 25Mar98
07/23 09:52:24 yS1 mgetty: experimental test release 1.1.16-Jul05
07/23 09:52:24 yS1 vgetty.c compiled at Jul 22 1998, 22:33:37
07/23 09:52:24 yS1 user id: 0, parent pid: 1
07/23 09:52:24 yS1 reading configuration data for port 'ttyS1'
--
Martin "Lolly" Lorenz
http://unet.univie.ac.at/~a9026080/
There is only one thing worse than Central Services...
...Microsoft
(in a world without fences - who needs Gates ... )