|
Hylafax Mailing List Archives
|
[Date Prev][Date Next][Thread Prev][Thread Next]
[Date Index]
[Thread Index]
Re: [hylafax-users] Hylafax and egetty
Hello George,
This is complete log from one session of vgetty with Log level 6. I saw
here that before AT#VLS=4, vgetty sends an ATA to modem for answering.
There is no ATA command in vm.log, so maybe, that's the problem.
06/08 09:25:53 SL0 waiting...
06/08 09:26:44 SL0 select returned 1
06/08 09:26:44 SL0 checking lockfiles, locking the line
06/08 09:26:44 SL0 makelock(ttySL0) called
06/08 09:26:44 SL0 do_makelock: lock='/var/lock/LCK..ttySL0'
06/08 09:26:44 SL0 lock made
06/08 09:26:44 SL0 vgetty: number of rings (1) was set directly
06/08 09:26:44 SL0 vgetty: decremented number of rings (1) by 0
06/08 09:26:44 SL0 vgetty: number of rings (1) too small, reseting to 2
06/08 09:26:44 SL0 wfr: waiting for ``RING''
06/08 09:26:44 SL0 got: [0a][0d][0a]RING[0d]
06/08 09:26:44 SL0 CND: RING
06/08 09:26:44 SL0 wfr: rc=0, drn=0
06/08 09:26:44 SL0 wfr: waiting for ``RING''
06/08 09:26:44 SL0 got: [0a][0d][0a]RING[0d]
06/08 09:26:49 SL0 CND: RING
06/08 09:26:49 SL0 wfr: rc=0, drn=0
06/08 09:26:49 SL0 setenv: 'CALLER_ID=none'
06/08 09:26:49 SL0 setenv: 'CONNECT='
06/08 09:26:49 SL0 setenv: 'DEVICE=ttySL0'
06/08 09:26:49 SL0 reading ring_type ring configuration from config
file /usr/local/etc/mgetty+sendfax/voice.conf
06/08 09:26:49 SL0 reading /usr/local/etc/mgetty+sendfax/voice.conf...
06/08 09:26:49 SL0 conf lib: read: 'part generic'
06/08 09:26:49 SL0 found CT_KEYWORD part generic
06/08 09:26:49 SL0 conf lib: read: 'voice_log_level 6'
06/08 09:26:49 SL0 conf lib: read:
'voice_shell_log /var/log/vgetty_voice_shell.%s'
06/08 09:26:49 SL0 conf lib: read: 'voice_dir /var/spool/voice'
06/08 09:26:49 SL0 conf lib: read: 'phone_owner root'
06/08 09:26:49 SL0 conf lib: read: 'phone_group phone'
06/08 09:26:49 SL0 conf lib: read: 'phone_mode 0777'
06/08 09:26:49 SL0 conf lib: read: 'message_flag_file .flag'
06/08 09:26:49 SL0 conf lib: read: 'receive_dir incoming'
06/08 09:26:49 SL0 conf lib: read: 'message_dir messages'
06/08 09:26:49 SL0 conf lib: read: 'message_list Index'
06/08 09:26:49 SL0 conf lib: read: 'backup_message standard.rmd'
06/08 09:26:49 SL0 conf lib: read: 'port_speed 115200'
06/08 09:26:49 SL0 conf lib: read: 'voice_shell /bin/sh'
06/08 09:26:49 SL0 conf lib: read: 'port_timeout 5'
06/08 09:26:49 SL0 conf lib: read: 'dial_timeout 90'
06/08 09:26:49 SL0 conf lib: read: 'command_delay 50'
06/08 09:26:49 SL0 conf lib: read: 'dtmf_len 30'
06/08 09:26:49 SL0 conf lib: read: 'dtmf_threshold 40'
06/08 09:26:49 SL0 conf lib: read: 'dtmf_wait 0'
06/08 09:26:49 SL0 conf lib: read: 'ignore_fax_dle false'
06/08 09:26:49 SL0 conf lib: read: 'raw_data false'
06/08 09:26:49 SL0 conf lib: read: 'rec_compression 4'
06/08 09:26:49 SL0 conf lib: read: 'rec_speed 0'
06/08 09:26:49 SL0 conf lib: read: 'rec_silence_len 70'
06/08 09:26:49 SL0 conf lib: read: 'rec_silence_threshold 65'
06/08 09:26:49 SL0 conf lib: read: 'rec_remove_silence false'
06/08 09:26:49 SL0 conf lib: read: 'rec_max_len 300'
06/08 09:26:49 SL0 conf lib: read: 'rec_min_len 0'
06/08 09:26:49 SL0 conf lib: read: 'do_hard_flow true'
06/08 09:26:49 SL0 conf lib: read: 'beep_frequency 933'
06/08 09:26:49 SL0 conf lib: read: 'beep_length 1500'
06/08 09:26:49 SL0 conf lib: read: 'max_tries 3'
06/08 09:26:49 SL0 conf lib: read: 'retry_delay 5'
06/08 09:26:49 SL0 conf lib: read: 'watchdog_timeout 60'
06/08 09:26:49 SL0 conf lib: read: 'receive_gain -1'
06/08 09:26:49 SL0 conf lib: read: 'transmit_gain -1'
06/08 09:26:49 SL0 conf lib: read: 'enable_command_echo false'
06/08 09:26:49 SL0 conf lib: read: 'poll_interval 5'
06/08 09:26:49 SL0 conf lib: read: 'program vgetty'
06/08 09:26:49 SL0 conf lib: read: 'rings 1'
06/08 09:26:49 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:26:49 SL0 conf lib: read: 'force_autodetect false'
06/08 09:26:49 SL0 conf lib: read: 'toll_saver_rings 0'
06/08 09:26:49 SL0 conf lib: read: 'rec_always_keep true'
06/08 09:26:49 SL0 conf lib: read: 'button_program '
06/08 09:26:49 SL0 conf lib: read: 'call_program '
06/08 09:26:49 SL0 conf lib: read: 'dtmf_program /home/rezac/dtmf.sh'
06/08 09:26:49 SL0 conf lib: read:
'message_program /home/rezac/sendskripta'
06/08 09:26:49 SL0 conf lib: read: 'do_message_light false'
06/08 09:26:49 SL0 conf lib: read: 'ring_report_delay -1'
06/08 09:26:49 SL0 conf lib: read: 'program vm'
06/08 09:26:49 SL0 conf lib: read: 'voice_devices ttySL0'
06/08 09:26:49 SL0 conf lib: read: 'dialout_timeout 90'
06/08 09:26:49 SL0 conf lib: read: 'ringback_goes_away 70'
06/08 09:26:49 SL0 conf lib: read: 'ringback_never_came 100'
06/08 09:26:49 SL0 conf lib: read: 'program pvf'
06/08 09:26:49 SL0 conf lib: read: 'port ttySL0'
06/08 09:26:49 SL0 conf lib: read: 'rings 1'
06/08 09:26:49 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:26:49 SL0 conf lib: read: 'ring_type virtual'
06/08 09:26:49 SL0 section: ring_type virtual, ignore
06/08 09:26:49 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:26:49 SL0 key: 'part', type=6, flags=4, data=(ignored)
06/08 09:26:49 SL0 key: 'program', type=6, flags=4, data=(ignored)
06/08 09:26:49 SL0 key: 'port', type=6, flags=4, data=(ignored)
06/08 09:26:49 SL0 key: 'ring_type', type=6, flags=4, data=(ignored)
06/08 09:26:49 SL0 key: 'voice_log_level', type=0, flags=3, data=6
06/08 09:26:49 SL0 key: 'voice_shell_log', type=1, flags=3,
data=/var/log/vgetty_voice_shell.%s
06/08 09:26:49 SL0 key: 'voice_shell', type=1, flags=3, data=/bin/sh
06/08 09:26:49 SL0 key: 'port_speed', type=0, flags=3, data=115200
06/08 09:26:49 SL0 key: 'port_timeout', type=0, flags=3, data=5
06/08 09:26:49 SL0 key: 'dial_timeout', type=0, flags=3, data=90
06/08 09:26:49 SL0 key: 'command_delay', type=0, flags=3, data=50
06/08 09:26:49 SL0 key: 'dtmf_len', type=0, flags=3, data=30
06/08 09:26:49 SL0 key: 'dtmf_threshold', type=0, flags=3, data=40
06/08 09:26:49 SL0 key: 'dtmf_wait', type=0, flags=3, data=0
06/08 09:26:49 SL0 key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
06/08 09:26:49 SL0 key: 'raw_data', type=3, flags=3, data=FALSE
06/08 09:26:49 SL0 key: 'rec_compression', type=0, flags=3, data=4
06/08 09:26:49 SL0 key: 'rec_speed', type=0, flags=3, data=0
06/08 09:26:49 SL0 key: 'rec_silence_len', type=0, flags=3, data=70
06/08 09:26:49 SL0 key: 'rec_silence_threshold', type=0, flags=3,
data=65
06/08 09:26:49 SL0 key: 'rec_remove_silence', type=3, flags=3,
data=FALSE
06/08 09:26:49 SL0 key: 'rec_max_len', type=0, flags=3, data=300
06/08 09:26:49 SL0 key: 'rec_min_len', type=0, flags=3, data=0
06/08 09:26:49 SL0 key: 'do_hard_flow', type=3, flags=3, data=TRUE
06/08 09:26:49 SL0 key: 'force_autodetect', type=3, flags=3,
data=FALSE
06/08 09:26:49 SL0 key: 'watchdog_timeout', type=0, flags=3, data=60
06/08 09:26:49 SL0 key: 'receive_gain', type=0, flags=3, data=50
06/08 09:26:49 SL0 key: 'transmit_gain', type=0, flags=3, data=50
06/08 09:26:49 SL0 key: 'enable_command_echo', type=3, flags=3,
data=FALSE
06/08 09:26:49 SL0 key: 'poll_interval', type=0, flags=3, data=5
06/08 09:26:49 SL0 key: 'forceV253', type=3, flags=1, data=FALSE
06/08 09:26:49 SL0 key: 'forceV253subset', type=3, flags=1, data=FALSE
06/08 09:26:49 SL0 key: 'enable_compression_mapping_querry', type=3,
flags=1, data=TRUE
06/08 09:26:49 SL0 key: 'compression_8bit_linear_signed', type=0,
flags=1, data=0
06/08 09:26:49 SL0 key: 'compression_16bit_linear_signed', type=0,
flags=1, data=0
06/08 09:26:49 SL0 key: 'compression_8bit_linear_unsigned', type=0,
flags=1, data=1
06/08 09:26:49 SL0 key: 'compression_8bit_ulaw', type=0, flags=1,
data=4
06/08 09:26:49 SL0 key: 'compression_8bit_alaw', type=0, flags=1,
data=5
06/08 09:26:49 SL0 key: 'compression_2bit_adpcm', type=0, flags=1,
data=140
06/08 09:26:49 SL0 key: 'compression_4bit_adpcm', type=0, flags=1,
data=141
06/08 09:26:49 SL0 key: 'compression_4bit_ima_adpcm', type=0, flags=1,
data=129
06/08 09:26:49 SL0 key: 'rings', type=1, flags=3, data=1
06/08 09:26:49 SL0 key: 'answer_mode', type=1, flags=3, data=voice:fax
06/08 09:26:49 SL0 key: 'toll_saver_rings', type=0, flags=3, data=0
06/08 09:26:49 SL0 key: 'rec_always_keep', type=3, flags=3, data=TRUE
06/08 09:26:49 SL0 key: 'voice_dir', type=1, flags=3,
data=/var/spool/voice
06/08 09:26:49 SL0 key: 'phone_owner', type=1, flags=3, data=root
06/08 09:26:49 SL0 key: 'phone_group', type=1, flags=3, data=phone
06/08 09:26:49 SL0 key: 'phone_mode', type=0, flags=3, data=511
06/08 09:26:49 SL0 key: 'message_flag_file', type=1, flags=3,
data=.flag
06/08 09:26:49 SL0 key: 'receive_dir', type=1, flags=3, data=incoming
06/08 09:26:49 SL0 key: 'message_dir', type=1, flags=3, data=messages
06/08 09:26:49 SL0 key: 'message_list', type=1, flags=3, data=Index
06/08 09:26:49 SL0 key: 'backup_message', type=1, flags=3,
data=standard.rmd
06/08 09:26:49 SL0 key: 'button_program', type=1, flags=3, data=
06/08 09:26:49 SL0 key: 'call_program', type=1, flags=3, data=
06/08 09:26:49 SL0 key: 'dtmf_program', type=1, flags=3,
data=/home/rezac/dtmf.sh
06/08 09:26:49 SL0 key: 'message_program', type=1, flags=3,
data=/home/rezac/sendskripta
06/08 09:26:49 SL0 key: 'do_message_light', type=3, flags=3,
data=FALSE
06/08 09:26:49 SL0 key: 'pre_message', type=1, flags=1, data=
06/08 09:26:49 SL0 key: 'beepsound', type=1, flags=1, data=
06/08 09:26:49 SL0 key: 'beep_frequency', type=0, flags=3, data=933
06/08 09:26:49 SL0 key: 'beep_length', type=0, flags=3, data=1500
06/08 09:26:49 SL0 key: 'max_tries', type=0, flags=3, data=3
06/08 09:26:49 SL0 key: 'retry_delay', type=0, flags=3, data=5
06/08 09:26:49 SL0 key: 'dialout_timeout', type=0, flags=1, data=90
06/08 09:26:49 SL0 key: 'ringback_goes_away', type=0, flags=1, data=70
06/08 09:26:49 SL0 key: 'ringback_never_came', type=0, flags=1,
data=100
06/08 09:26:49 SL0 key: 'ring_report_delay', type=0, flags=3, data=-1
06/08 09:26:49 SL0 key: 'voice_devices', type=1, flags=1, data=
06/08 09:26:49 SL0 vgetty: answer mode was set directly
06/08 09:26:49 SL0 vgetty: answer mode is [fax|voice]
06/08 09:26:49 SL0 vgetty: opening list
file /var/spool/voice/messages/Index
06/08 09:26:49 SL0 vgetty: message name
is /var/spool/voice/messages/standard.rmd
06/08 09:26:49 SL0 vgetty: entering voice mode
06/08 09:26:49 SL0 vgetty: Installing signal handlers
06/08 09:26:49 SL0 voice command: 'AT#CLS?' -> ''
06/08 09:26:49 SL0 vgetty: AT#CLS?
06/08 09:26:49 SL0 Rockwell: 0
06/08 09:26:49 SL0 voice command: '' -> 'OK'
06/08 09:26:49 SL0 Rockwell: OK
06/08 09:26:49 SL0 voice command: 'AT#CLS=8' -> 'OK'
06/08 09:26:50 SL0 vgetty: AT#CLS=8
06/08 09:26:50 SL0 Rockwell: OK
06/08 09:26:50 SL0 voice command: 'AT' -> 'OK'
06/08 09:26:50 SL0 vgetty: AT
06/08 09:26:50 SL0 Rockwell: OK
06/08 09:26:50 SL0 voice command: 'ATA' -> 'VCON'
06/08 09:26:50 SL0 vgetty: ATA
06/08 09:26:50 SL0 Rockwell: VCON
06/08 09:26:50 SL0 vgetty: queued event RESET_WATCHDOG at position
0001
06/08 09:26:50 SL0 voice command: 'AT#VLS=4' -> 'OK'
06/08 09:26:50 SL0 vgetty: AT#VLS=4
06/08 09:26:50 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0001
06/08 09:26:50 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:26:50 SL0 Rockwell: OK
06/08 09:26:50 SL0 playing voice
file /var/spool/voice/messages/standard.rmd
06/08 09:26:50 SL0 vgetty: raw modem data header found
06/08 09:26:50 SL0 vgetty: modem type Rockwell found
06/08 09:26:50 SL0 vgetty: compression method 0x0004, speed 7200, bits
4
06/08 09:26:50 SL0 vgetty: queued event RESET_WATCHDOG at position
0002
06/08 09:26:50 SL0 voice command: 'AT#VBS=4' -> 'OK'
06/08 09:26:50 SL0 vgetty: AT#VBS=4
06/08 09:26:50 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0002
06/08 09:26:50 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:26:50 SL0 Rockwell: OK
06/08 09:26:50 SL0 vgetty: queued event RESET_WATCHDOG at position
0003
06/08 09:26:50 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0003
06/08 09:26:50 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:26:50 SL0 voice command: 'AT&K3' -> 'OK'
06/08 09:26:50 SL0 vgetty: AT&K3
06/08 09:26:50 SL0 Rockwell: OK
06/08 09:26:50 SL0 tio_set_flow_control( HARD XON_OUT )
06/08 09:26:50 SL0 voice command: 'AT#VTX' -> 'CONNECT'
06/08 09:26:50 SL0 vgetty: AT#VTX
06/08 09:26:50 SL0 Rockwell: CONNECT
06/08 09:26:51 SL0 vgetty: <VOICE DATA 4536 bytes>
06/08 09:26:51 SL0 vgetty: queued event RESET_WATCHDOG at position
0004
06/08 09:26:51 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0004
06/08 09:26:51 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:26:51 SL0 vgetty: <STOP PLAY>
06/08 09:26:51 SL0 voice command: '' -> 'OK|VCON'
06/08 09:26:51 SL0 Rockwell: VCON
06/08 09:26:52 SL0 vgetty: queued event RESET_WATCHDOG at position
0005
06/08 09:26:52 SL0 voice command: 'AT#VTS=[933,0,15]' -> ''
06/08 09:26:52 SL0 vgetty: AT#VTS=[933,0,15]
06/08 09:26:52 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0005
06/08 09:26:52 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:26:53 SL0 voice command: '' -> 'OK'
06/08 09:26:53 SL0 Rockwell: OK
06/08 09:26:54 SL0 recording voice
file /var/spool/voice/incoming/v-2726-1118215610.rmd
06/08 09:26:54 SL0 vgetty: queued event RESET_WATCHDOG at position
0006
06/08 09:26:54 SL0 voice command: 'AT#VBS=4' -> 'OK'
06/08 09:26:54 SL0 vgetty: AT#VBS=4
06/08 09:26:54 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0006
06/08 09:26:54 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:26:54 SL0 Rockwell: OK
06/08 09:26:54 SL0 vgetty: queued event RESET_WATCHDOG at position
0007
06/08 09:26:54 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0007
06/08 09:26:54 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:26:54 SL0 voice command: 'AT&K3' -> 'OK'
06/08 09:26:54 SL0 vgetty: AT&K3
06/08 09:26:54 SL0 Rockwell: OK
06/08 09:26:54 SL0 tio_set_flow_control( HARD XON_IN )
06/08 09:26:54 SL0 voice command: 'AT#VRX' -> 'CONNECT'
06/08 09:26:54 SL0 vgetty: AT#VRX
06/08 09:26:54 SL0 Rockwell: CONNECT
06/08 09:27:12 SL0 Rockwell: <DLE> <d>
06/08 09:27:12 SL0 vgetty: queued event DIAL_TONE at position 0008
06/08 09:27:12 SL0 vgetty: unqueued event DIAL_TONE at position 0008
06/08 09:27:12 SL0 vgetty: voice_handle_event got event DIAL_TONE
with data <4>
06/08 09:27:12 SL0 vgetty: <STOP RECORDING>
06/08 09:27:12 SL0 Rockwell: <VOICE DATA 63651 bytes>
06/08 09:27:12 SL0 Rockwell: <DLE> <ETX>
06/08 09:27:12 SL0 vgetty: <DLE> <ETX> received
06/08 09:27:12 SL0 voice command: '' -> 'OK|VCON'
06/08 09:27:12 SL0 Rockwell: VCON
06/08 09:27:12 SL0 vgetty: queued event RESET_WATCHDOG at position
0009
06/08 09:27:12 SL0 voice command: 'ATH0' -> 'VCON|OK'
06/08 09:27:12 SL0 vgetty: ATH0
06/08 09:27:12 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0009
06/08 09:27:12 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <4>
06/08 09:27:12 SL0 Rockwell: OK
06/08 09:27:12 SL0 voice command: 'AT#CLS=8' -> 'OK'
06/08 09:27:12 SL0 vgetty: AT#CLS=8
06/08 09:27:12 SL0 Rockwell: OK
06/08 09:27:12 SL0 voice command: 'AT#VLS=0' -> 'OK'
06/08 09:27:12 SL0 vgetty: AT#VLS=0
06/08 09:27:12 SL0 Rockwell: OK
06/08 09:27:12 SL0 vgetty: leaving voice mode
06/08 09:27:12 SL0 voice command: 'AT#CLS=0' -> 'OK'
06/08 09:27:12 SL0 vgetty: AT#CLS=0
06/08 09:27:12 SL0 Rockwell: OK
06/08 09:27:12 SL0 voice command: 'AT' -> 'OK'
06/08 09:27:12 SL0 vgetty: AT
06/08 09:27:12 SL0 Rockwell: OK
06/08 09:27:12 SL0 vgetty: Restoring signal handlers
06/08 09:27:12 SL0 closing voice modem device
06/08 09:27:12 SL0 removing lock file
06/08 09:27:12 ##### message keep, length=00:00:18, name='',
caller=none, dev=ttySL0, pid=2726
06/08 09:27:12 SL0 vgetty: creating message flag
file /var/spool/voice/.flag
06/08 09:27:12 SL0 executing message program, dev=ttySL0, pid=2726
06/08 09:27:12 SL0 vgetty: Executing shell
script /home/rezac/sendskripta with shell /bin/sh
06/08 09:27:12 SL0 vgetty: opening pipes
06/08 09:27:12 SL0 vgetty: forking shell
06/08 09:27:12 SL0 vgetty(0): HELLO SHELL
06/08 09:27:15 SL0 vgetty: shell exited normally with status 0x0000
--
06/08 09:27:15 SL0 vgetty: experimental test release 0.9.32 / with
duplex patch
06/08 09:27:15 SL0 mgetty: interim release 1.1.33-Apr10
06/08 09:27:15 SL0 reading generic configuration from config
file /usr/local/etc/mgetty+sendfax/voice.conf
06/08 09:27:15 SL0 reading program vgetty configuration from config
file /usr/local/etc/mgetty+sendfax/voice.conf
06/08 09:27:15 SL0 reading /usr/local/etc/mgetty+sendfax/voice.conf...
06/08 09:27:15 SL0 conf lib: read: 'part generic'
06/08 09:27:15 SL0 found CT_KEYWORD part generic
06/08 09:27:15 SL0 conf lib: read: 'voice_log_level 6'
06/08 09:27:15 SL0 conf lib: read:
'voice_shell_log /var/log/vgetty_voice_shell.%s'
06/08 09:27:15 SL0 conf lib: read: 'voice_dir /var/spool/voice'
06/08 09:27:15 SL0 conf lib: read: 'phone_owner root'
06/08 09:27:15 SL0 conf lib: read: 'phone_group phone'
06/08 09:27:15 SL0 conf lib: read: 'phone_mode 0777'
06/08 09:27:15 SL0 conf lib: read: 'message_flag_file .flag'
06/08 09:27:15 SL0 conf lib: read: 'receive_dir incoming'
06/08 09:27:15 SL0 conf lib: read: 'message_dir messages'
06/08 09:27:15 SL0 conf lib: read: 'message_list Index'
06/08 09:27:15 SL0 conf lib: read: 'backup_message standard.rmd'
06/08 09:27:15 SL0 conf lib: read: 'port_speed 115200'
06/08 09:27:15 SL0 conf lib: read: 'voice_shell /bin/sh'
06/08 09:27:15 SL0 conf lib: read: 'port_timeout 5'
06/08 09:27:15 SL0 conf lib: read: 'dial_timeout 90'
06/08 09:27:15 SL0 conf lib: read: 'command_delay 50'
06/08 09:27:15 SL0 conf lib: read: 'dtmf_len 30'
06/08 09:27:15 SL0 conf lib: read: 'dtmf_threshold 40'
06/08 09:27:15 SL0 conf lib: read: 'dtmf_wait 0'
06/08 09:27:15 SL0 conf lib: read: 'ignore_fax_dle false'
06/08 09:27:15 SL0 conf lib: read: 'raw_data false'
06/08 09:27:15 SL0 conf lib: read: 'rec_compression 4'
06/08 09:27:15 SL0 conf lib: read: 'rec_speed 0'
06/08 09:27:15 SL0 conf lib: read: 'rec_silence_len 70'
06/08 09:27:15 SL0 conf lib: read: 'rec_silence_threshold 65'
06/08 09:27:15 SL0 conf lib: read: 'rec_remove_silence false'
06/08 09:27:15 SL0 conf lib: read: 'rec_max_len 300'
06/08 09:27:15 SL0 conf lib: read: 'rec_min_len 0'
06/08 09:27:15 SL0 conf lib: read: 'do_hard_flow true'
06/08 09:27:15 SL0 conf lib: read: 'beep_frequency 933'
06/08 09:27:15 SL0 conf lib: read: 'beep_length 1500'
06/08 09:27:15 SL0 conf lib: read: 'max_tries 3'
06/08 09:27:15 SL0 conf lib: read: 'retry_delay 5'
06/08 09:27:15 SL0 conf lib: read: 'watchdog_timeout 60'
06/08 09:27:15 SL0 conf lib: read: 'receive_gain -1'
06/08 09:27:15 SL0 conf lib: read: 'transmit_gain -1'
06/08 09:27:15 SL0 conf lib: read: 'enable_command_echo false'
06/08 09:27:15 SL0 conf lib: read: 'poll_interval 5'
06/08 09:27:15 SL0 conf lib: read: 'program vgetty'
06/08 09:27:15 SL0 section: program vgetty, **found**
06/08 09:27:15 SL0 conf lib: read: 'rings 1'
06/08 09:27:15 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:27:15 SL0 conf lib: read: 'force_autodetect false'
06/08 09:27:15 SL0 conf lib: read: 'toll_saver_rings 0'
06/08 09:27:15 SL0 conf lib: read: 'rec_always_keep true'
06/08 09:27:15 SL0 conf lib: read: 'button_program '
06/08 09:27:15 SL0 conf lib: read: 'call_program '
06/08 09:27:15 SL0 conf lib: read: 'dtmf_program /home/rezac/dtmf.sh'
06/08 09:27:15 SL0 conf lib: read:
'message_program /home/rezac/sendskripta'
06/08 09:27:15 SL0 conf lib: read: 'do_message_light false'
06/08 09:27:15 SL0 conf lib: read: 'ring_report_delay -1'
06/08 09:27:15 SL0 conf lib: read: 'program vm'
06/08 09:27:15 SL0 section: program vm, ignore
06/08 09:27:15 SL0 conf lib: read: 'voice_devices ttySL0'
06/08 09:27:15 SL0 conf lib: read: 'dialout_timeout 90'
06/08 09:27:15 SL0 conf lib: read: 'ringback_goes_away 70'
06/08 09:27:15 SL0 conf lib: read: 'ringback_never_came 100'
06/08 09:27:15 SL0 conf lib: read: 'program pvf'
06/08 09:27:15 SL0 section: program pvf, ignore
06/08 09:27:15 SL0 conf lib: read: 'port ttySL0'
06/08 09:27:15 SL0 conf lib: read: 'rings 1'
06/08 09:27:15 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:27:15 SL0 conf lib: read: 'ring_type virtual'
06/08 09:27:15 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:27:15 SL0 key: 'part', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'program', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'port', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'ring_type', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'voice_log_level', type=0, flags=3, data=6
06/08 09:27:15 SL0 key: 'voice_shell_log', type=1, flags=3,
data=/var/log/vgetty_voice_shell.%s
06/08 09:27:15 SL0 key: 'voice_shell', type=1, flags=3, data=/bin/sh
06/08 09:27:15 SL0 key: 'port_speed', type=0, flags=3, data=115200
06/08 09:27:15 SL0 key: 'port_timeout', type=0, flags=3, data=5
06/08 09:27:15 SL0 key: 'dial_timeout', type=0, flags=3, data=90
06/08 09:27:15 SL0 key: 'command_delay', type=0, flags=3, data=50
06/08 09:27:15 SL0 key: 'dtmf_len', type=0, flags=3, data=30
06/08 09:27:15 SL0 key: 'dtmf_threshold', type=0, flags=3, data=40
06/08 09:27:15 SL0 key: 'dtmf_wait', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
06/08 09:27:15 SL0 key: 'raw_data', type=3, flags=3, data=FALSE
06/08 09:27:15 SL0 key: 'rec_compression', type=0, flags=3, data=4
06/08 09:27:15 SL0 key: 'rec_speed', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'rec_silence_len', type=0, flags=3, data=70
06/08 09:27:15 SL0 key: 'rec_silence_threshold', type=0, flags=3,
data=65
06/08 09:27:15 SL0 key: 'rec_remove_silence', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'rec_max_len', type=0, flags=3, data=300
06/08 09:27:15 SL0 key: 'rec_min_len', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'do_hard_flow', type=3, flags=3, data=TRUE
06/08 09:27:15 SL0 key: 'force_autodetect', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'watchdog_timeout', type=0, flags=3, data=60
06/08 09:27:15 SL0 key: 'receive_gain', type=0, flags=3, data=-1
06/08 09:27:15 SL0 key: 'transmit_gain', type=0, flags=3, data=-1
06/08 09:27:15 SL0 key: 'enable_command_echo', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'poll_interval', type=0, flags=3, data=5
06/08 09:27:15 SL0 key: 'forceV253', type=3, flags=1, data=FALSE
06/08 09:27:15 SL0 key: 'forceV253subset', type=3, flags=1, data=FALSE
06/08 09:27:15 SL0 key: 'enable_compression_mapping_querry', type=3,
flags=1, data=TRUE
06/08 09:27:15 SL0 key: 'compression_8bit_linear_signed', type=0,
flags=1, data=0
06/08 09:27:15 SL0 key: 'compression_16bit_linear_signed', type=0,
flags=1, data=0
06/08 09:27:15 SL0 key: 'compression_8bit_linear_unsigned', type=0,
flags=1, data=1
06/08 09:27:15 SL0 key: 'compression_8bit_ulaw', type=0, flags=1,
data=4
06/08 09:27:15 SL0 key: 'compression_8bit_alaw', type=0, flags=1,
data=5
06/08 09:27:15 SL0 key: 'compression_2bit_adpcm', type=0, flags=1,
data=140
06/08 09:27:15 SL0 key: 'compression_4bit_adpcm', type=0, flags=1,
data=141
06/08 09:27:15 SL0 key: 'compression_4bit_ima_adpcm', type=0, flags=1,
data=129
06/08 09:27:15 SL0 key: 'rings', type=1, flags=3, data=1
06/08 09:27:15 SL0 key: 'answer_mode', type=1, flags=3, data=voice:fax
06/08 09:27:15 SL0 key: 'toll_saver_rings', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'rec_always_keep', type=3, flags=3, data=TRUE
06/08 09:27:15 SL0 key: 'voice_dir', type=1, flags=3,
data=/var/spool/voice
06/08 09:27:15 SL0 key: 'phone_owner', type=1, flags=3, data=root
06/08 09:27:15 SL0 key: 'phone_group', type=1, flags=3, data=phone
06/08 09:27:15 SL0 key: 'phone_mode', type=0, flags=3, data=511
06/08 09:27:15 SL0 key: 'message_flag_file', type=1, flags=3,
data=.flag
06/08 09:27:15 SL0 key: 'receive_dir', type=1, flags=3, data=incoming
06/08 09:27:15 SL0 key: 'message_dir', type=1, flags=3, data=messages
06/08 09:27:15 SL0 key: 'message_list', type=1, flags=3, data=Index
06/08 09:27:15 SL0 key: 'backup_message', type=1, flags=3,
data=standard.rmd
06/08 09:27:15 SL0 key: 'button_program', type=1, flags=3, data=
06/08 09:27:15 SL0 key: 'call_program', type=1, flags=3, data=
06/08 09:27:15 SL0 key: 'dtmf_program', type=1, flags=3,
data=/home/rezac/dtmf.sh
06/08 09:27:15 SL0 key: 'message_program', type=1, flags=3,
data=/home/rezac/sendskripta
06/08 09:27:15 SL0 key: 'do_message_light', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'pre_message', type=1, flags=1, data=
06/08 09:27:15 SL0 key: 'beepsound', type=1, flags=1, data=
06/08 09:27:15 SL0 key: 'beep_frequency', type=0, flags=3, data=933
06/08 09:27:15 SL0 key: 'beep_length', type=0, flags=3, data=1500
06/08 09:27:15 SL0 key: 'max_tries', type=0, flags=3, data=3
06/08 09:27:15 SL0 key: 'retry_delay', type=0, flags=3, data=5
06/08 09:27:15 SL0 key: 'dialout_timeout', type=0, flags=1, data=90
06/08 09:27:15 SL0 key: 'ringback_goes_away', type=0, flags=1, data=70
06/08 09:27:15 SL0 key: 'ringback_never_came', type=0, flags=1,
data=100
06/08 09:27:15 SL0 key: 'ring_report_delay', type=0, flags=3, data=-1
06/08 09:27:15 SL0 key: 'voice_devices', type=1, flags=1, data=
06/08 09:27:15 SL0 reading port ttySL0 configuration from config
file /usr/local/etc/mgetty+sendfax/voice.conf
06/08 09:27:15 SL0 reading /usr/local/etc/mgetty+sendfax/voice.conf...
06/08 09:27:15 SL0 conf lib: read: 'part generic'
06/08 09:27:15 SL0 found CT_KEYWORD part generic
06/08 09:27:15 SL0 conf lib: read: 'voice_log_level 6'
06/08 09:27:15 SL0 conf lib: read:
'voice_shell_log /var/log/vgetty_voice_shell.%s'
06/08 09:27:15 SL0 conf lib: read: 'voice_dir /var/spool/voice'
06/08 09:27:15 SL0 conf lib: read: 'phone_owner root'
06/08 09:27:15 SL0 conf lib: read: 'phone_group phone'
06/08 09:27:15 SL0 conf lib: read: 'phone_mode 0777'
06/08 09:27:15 SL0 conf lib: read: 'message_flag_file .flag'
06/08 09:27:15 SL0 conf lib: read: 'receive_dir incoming'
06/08 09:27:15 SL0 conf lib: read: 'message_dir messages'
06/08 09:27:15 SL0 conf lib: read: 'message_list Index'
06/08 09:27:15 SL0 conf lib: read: 'backup_message standard.rmd'
06/08 09:27:15 SL0 conf lib: read: 'port_speed 115200'
06/08 09:27:15 SL0 conf lib: read: 'voice_shell /bin/sh'
06/08 09:27:15 SL0 conf lib: read: 'port_timeout 5'
06/08 09:27:15 SL0 conf lib: read: 'dial_timeout 90'
06/08 09:27:15 SL0 conf lib: read: 'command_delay 50'
06/08 09:27:15 SL0 conf lib: read: 'dtmf_len 30'
06/08 09:27:15 SL0 conf lib: read: 'dtmf_threshold 40'
06/08 09:27:15 SL0 conf lib: read: 'dtmf_wait 0'
06/08 09:27:15 SL0 conf lib: read: 'ignore_fax_dle false'
06/08 09:27:15 SL0 conf lib: read: 'raw_data false'
06/08 09:27:15 SL0 conf lib: read: 'rec_compression 4'
06/08 09:27:15 SL0 conf lib: read: 'rec_speed 0'
06/08 09:27:15 SL0 conf lib: read: 'rec_silence_len 70'
06/08 09:27:15 SL0 conf lib: read: 'rec_silence_threshold 65'
06/08 09:27:15 SL0 conf lib: read: 'rec_remove_silence false'
06/08 09:27:15 SL0 conf lib: read: 'rec_max_len 300'
06/08 09:27:15 SL0 conf lib: read: 'rec_min_len 0'
06/08 09:27:15 SL0 conf lib: read: 'do_hard_flow true'
06/08 09:27:15 SL0 conf lib: read: 'beep_frequency 933'
06/08 09:27:15 SL0 conf lib: read: 'beep_length 1500'
06/08 09:27:15 SL0 conf lib: read: 'max_tries 3'
06/08 09:27:15 SL0 conf lib: read: 'retry_delay 5'
06/08 09:27:15 SL0 conf lib: read: 'watchdog_timeout 60'
06/08 09:27:15 SL0 conf lib: read: 'receive_gain -1'
06/08 09:27:15 SL0 conf lib: read: 'transmit_gain -1'
06/08 09:27:15 SL0 conf lib: read: 'enable_command_echo false'
06/08 09:27:15 SL0 conf lib: read: 'poll_interval 5'
06/08 09:27:15 SL0 conf lib: read: 'program vgetty'
06/08 09:27:15 SL0 conf lib: read: 'rings 1'
06/08 09:27:15 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:27:15 SL0 conf lib: read: 'force_autodetect false'
06/08 09:27:15 SL0 conf lib: read: 'toll_saver_rings 0'
06/08 09:27:15 SL0 conf lib: read: 'rec_always_keep true'
06/08 09:27:15 SL0 conf lib: read: 'button_program '
06/08 09:27:15 SL0 conf lib: read: 'call_program '
06/08 09:27:15 SL0 conf lib: read: 'dtmf_program /home/rezac/dtmf.sh'
06/08 09:27:15 SL0 conf lib: read:
'message_program /home/rezac/sendskripta'
06/08 09:27:15 SL0 conf lib: read: 'do_message_light false'
06/08 09:27:15 SL0 conf lib: read: 'ring_report_delay -1'
06/08 09:27:15 SL0 conf lib: read: 'program vm'
06/08 09:27:15 SL0 conf lib: read: 'voice_devices ttySL0'
06/08 09:27:15 SL0 conf lib: read: 'dialout_timeout 90'
06/08 09:27:15 SL0 conf lib: read: 'ringback_goes_away 70'
06/08 09:27:15 SL0 conf lib: read: 'ringback_never_came 100'
06/08 09:27:15 SL0 conf lib: read: 'program pvf'
06/08 09:27:15 SL0 conf lib: read: 'port ttySL0'
06/08 09:27:15 SL0 section: port ttySL0, **found**
06/08 09:27:15 SL0 conf lib: read: 'rings 1'
06/08 09:27:15 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:27:15 SL0 conf lib: read: 'ring_type virtual'
06/08 09:27:15 SL0 found CT_KEYWORD ring_type virtual
06/08 09:27:15 SL0 conf lib: read: 'answer_mode voice:fax'
06/08 09:27:15 SL0 key: 'part', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'program', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'port', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'ring_type', type=6, flags=4, data=(ignored)
06/08 09:27:15 SL0 key: 'voice_log_level', type=0, flags=3, data=6
06/08 09:27:15 SL0 key: 'voice_shell_log', type=1, flags=3,
data=/var/log/vgetty_voice_shell.%s
06/08 09:27:15 SL0 key: 'voice_shell', type=1, flags=3, data=/bin/sh
06/08 09:27:15 SL0 key: 'port_speed', type=0, flags=3, data=115200
06/08 09:27:15 SL0 key: 'port_timeout', type=0, flags=3, data=5
06/08 09:27:15 SL0 key: 'dial_timeout', type=0, flags=3, data=90
06/08 09:27:15 SL0 key: 'command_delay', type=0, flags=3, data=50
06/08 09:27:15 SL0 key: 'dtmf_len', type=0, flags=3, data=30
06/08 09:27:15 SL0 key: 'dtmf_threshold', type=0, flags=3, data=40
06/08 09:27:15 SL0 key: 'dtmf_wait', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'ignore_fax_dle', type=3, flags=3, data=FALSE
06/08 09:27:15 SL0 key: 'raw_data', type=3, flags=3, data=FALSE
06/08 09:27:15 SL0 key: 'rec_compression', type=0, flags=3, data=4
06/08 09:27:15 SL0 key: 'rec_speed', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'rec_silence_len', type=0, flags=3, data=70
06/08 09:27:15 SL0 key: 'rec_silence_threshold', type=0, flags=3,
data=65
06/08 09:27:15 SL0 key: 'rec_remove_silence', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'rec_max_len', type=0, flags=3, data=300
06/08 09:27:15 SL0 key: 'rec_min_len', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'do_hard_flow', type=3, flags=3, data=TRUE
06/08 09:27:15 SL0 key: 'force_autodetect', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'watchdog_timeout', type=0, flags=3, data=60
06/08 09:27:15 SL0 key: 'receive_gain', type=0, flags=3, data=-1
06/08 09:27:15 SL0 key: 'transmit_gain', type=0, flags=3, data=-1
06/08 09:27:15 SL0 key: 'enable_command_echo', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'poll_interval', type=0, flags=3, data=5
06/08 09:27:15 SL0 key: 'forceV253', type=3, flags=1, data=FALSE
06/08 09:27:15 SL0 key: 'forceV253subset', type=3, flags=1, data=FALSE
06/08 09:27:15 SL0 key: 'enable_compression_mapping_querry', type=3,
flags=1, data=TRUE
06/08 09:27:15 SL0 key: 'compression_8bit_linear_signed', type=0,
flags=1, data=0
06/08 09:27:15 SL0 key: 'compression_16bit_linear_signed', type=0,
flags=1, data=0
06/08 09:27:15 SL0 key: 'compression_8bit_linear_unsigned', type=0,
flags=1, data=1
06/08 09:27:15 SL0 key: 'compression_8bit_ulaw', type=0, flags=1,
data=4
06/08 09:27:15 SL0 key: 'compression_8bit_alaw', type=0, flags=1,
data=5
06/08 09:27:15 SL0 key: 'compression_2bit_adpcm', type=0, flags=1,
data=140
06/08 09:27:15 SL0 key: 'compression_4bit_adpcm', type=0, flags=1,
data=141
06/08 09:27:15 SL0 key: 'compression_4bit_ima_adpcm', type=0, flags=1,
data=129
06/08 09:27:15 SL0 key: 'rings', type=1, flags=3, data=1
06/08 09:27:15 SL0 key: 'answer_mode', type=1, flags=3, data=voice:fax
06/08 09:27:15 SL0 key: 'toll_saver_rings', type=0, flags=3, data=0
06/08 09:27:15 SL0 key: 'rec_always_keep', type=3, flags=3, data=TRUE
06/08 09:27:15 SL0 key: 'voice_dir', type=1, flags=3,
data=/var/spool/voice
06/08 09:27:15 SL0 key: 'phone_owner', type=1, flags=3, data=root
06/08 09:27:15 SL0 key: 'phone_group', type=1, flags=3, data=phone
06/08 09:27:15 SL0 key: 'phone_mode', type=0, flags=3, data=511
06/08 09:27:15 SL0 key: 'message_flag_file', type=1, flags=3,
data=.flag
06/08 09:27:15 SL0 key: 'receive_dir', type=1, flags=3, data=incoming
06/08 09:27:15 SL0 key: 'message_dir', type=1, flags=3, data=messages
06/08 09:27:15 SL0 key: 'message_list', type=1, flags=3, data=Index
06/08 09:27:15 SL0 key: 'backup_message', type=1, flags=3,
data=standard.rmd
06/08 09:27:15 SL0 key: 'button_program', type=1, flags=3, data=
06/08 09:27:15 SL0 key: 'call_program', type=1, flags=3, data=
06/08 09:27:15 SL0 key: 'dtmf_program', type=1, flags=3,
data=/home/rezac/dtmf.sh
06/08 09:27:15 SL0 key: 'message_program', type=1, flags=3,
data=/home/rezac/sendskripta
06/08 09:27:15 SL0 key: 'do_message_light', type=3, flags=3,
data=FALSE
06/08 09:27:15 SL0 key: 'pre_message', type=1, flags=1, data=
06/08 09:27:15 SL0 key: 'beepsound', type=1, flags=1, data=
06/08 09:27:15 SL0 key: 'beep_frequency', type=0, flags=3, data=933
06/08 09:27:15 SL0 key: 'beep_length', type=0, flags=3, data=1500
06/08 09:27:15 SL0 key: 'max_tries', type=0, flags=3, data=3
06/08 09:27:15 SL0 key: 'retry_delay', type=0, flags=3, data=5
06/08 09:27:15 SL0 key: 'dialout_timeout', type=0, flags=1, data=90
06/08 09:27:15 SL0 key: 'ringback_goes_away', type=0, flags=1, data=70
06/08 09:27:15 SL0 key: 'ringback_never_came', type=0, flags=1,
data=100
06/08 09:27:15 SL0 key: 'ring_report_delay', type=0, flags=3, data=-1
06/08 09:27:15 SL0 key: 'voice_devices', type=1, flags=1, data=
06/08 09:27:15 SL0 check for lockfiles
06/08 09:27:15 SL0 checklock: stat failed, no file
06/08 09:27:15 SL0 locking the line
06/08 09:27:15 SL0 makelock(ttySL0) called
06/08 09:27:15 SL0 do_makelock: lock='/var/lock/LCK..ttySL0'
06/08 09:27:15 SL0 lock made
06/08 09:27:16 SL0 tio_get_rs232_lines: status: CTS DSR
06/08 09:27:16 SL0 lowering DTR to reset Modem
06/08 09:27:16 SL0 tss: set speed to 38400 (017)
06/08 09:27:16 SL0 tio_set_flow_control( HARD )
06/08 09:27:16 SL0 waiting for line to clear (VTIME=1), read:
06/08 09:27:17 SL0 send: \dATQ0V1H0[0d]
06/08 09:27:17 SL0 waiting for ``OK''
06/08 09:27:17 SL0 got: ATQ0V1H0[0d]
06/08 09:27:17 SL0 CND: ATQ0V1H0[0d][0a]OK ** found **
06/08 09:27:17 SL0 send: ATS0=0X3Q0&D3&C1[0d]
06/08 09:27:17 SL0 waiting for ``OK''
06/08 09:27:17 SL0 got: [0d]
06/08 09:27:17 SL0 CND: OK[0a]ATS0=0X3Q0&D3&C1[0d]
06/08 09:27:17 SL0 CND: ATS0=0X3Q0&D3&C1[0d][0a]OK ** found **
06/08 09:27:17 SL0 mdm_send: 'ATI'
06/08 09:27:17 SL0 got:[0d][0a]ATI[0d]
06/08 09:27:17 SL0 got:[0d][0a]56000[0d]
06/08 09:27:17 SL0 mdm_gis: string 1: '56000'
06/08 09:27:17 SL0 got:[0a][0d][0a]OK[0d]
06/08 09:27:17 SL0 mdm_identify: string '56000'
06/08 09:27:17 SL0 Generic Rockwell modem (56000)
06/08 09:27:17 SL0 mdm_send: 'ATI3'
06/08 09:27:17 SL0 got:[0a]ATI3[0d]
06/08 09:27:17 SL0 got:[0d][0a]unknown[0d]
06/08 09:27:17 SL0 mdm_gis: string 1: 'unknown'
06/08 09:27:17 SL0 got:[0a]Smart Link compatible modem[0d]
06/08 09:27:17 SL0 mdm_gis: string 2: 'Smart Link compatible modem'
06/08 09:27:17 SL0 got:[0a][0d][0a]OK[0d]
06/08 09:27:17 SL0 mdm_send: 'ATI4'
06/08 09:27:17 SL0 got:[0a]ATI4[0d]
06/08 09:27:17 SL0 got:[0d][0a]Active Profile:[0d]
06/08 09:27:17 SL0 mdm_gis: string 1: 'Active Profile:'
06/08 09:27:17 SL0 got:[0a]S00=000 S01=000 S02=043 S03=013 S04=010
S05=008 S06=002 S07=060[0d]
06/08 09:27:17 SL0 mdm_gis: string 2: 'S00=000 S01=000 S02=043 S03=013
S04=010 S05=008 S06=002 S07=060'
06/08 09:27:17 SL0 got:[0a]S08=002 S09=006 S10=128 S11=100 S12=050
S13=001 S14=000 S15=001[0d]
06/08 09:27:17 SL0 mdm_gis: string 3: 'S08=002 S09=006 S10=128 S11=100
S12=050 S13=001 S14=000 S15=001'
06/08 09:27:17 SL0 got:[0a]S16=001 S17=000 S18=000 S19=000 S20=000
S21=000 S22=000 S23=000[0d]
06/08 09:27:17 SL0 mdm_gis: string 4: 'S16=001 S17=000 S18=000 S19=000
S20=000 S21=000 S22=000 S23=000'
06/08 09:27:17 SL0 got:[0a]S24=050 S25=000 S26=000 S27=008 S28=000
S29=001 S30=002 S31=001[0d]
06/08 09:27:17 SL0 mdm_gis: string 5: 'S24=050 S25=000 S26=000 S27=008
S28=000 S29=001 S30=002 S31=001'
06/08 09:27:17 SL0 got:[0a][0d][0a][0d][0a]OK[0d]
06/08 09:27:17 SL0 additional info: 'Active Profile:'
06/08 09:27:17 SL0 modem quirks: 0004
06/08 09:27:17 SL0 mdm_send: 'AT+FCLASS=2'
06/08 09:27:17 SL0 got:[0a]AT+FCLASS=2[0d]
06/08 09:27:17 SL0 mdm_command: string 'AT+FCLASS=2'
06/08 09:27:17 SL0 got:[0d][0a]ERROR[0d]
06/08 09:27:17 SL0 mdm_command: string 'ERROR' -> ERROR
06/08 09:27:18 SL0 mdm_send: 'AT+FCLASS=2.0'
06/08 09:27:18 SL0 got:[0a]AT+FCLASS=2.0[0d]
06/08 09:27:18 SL0 mdm_command: string 'AT+FCLASS=2.0'
06/08 09:27:18 SL0 got:[0d][0a]ERROR[0d]
06/08 09:27:18 SL0 mdm_command: string 'ERROR' -> ERROR
06/08 09:27:18 SL0 mdm_send: 'AT+FCLASS=2'
06/08 09:27:18 SL0 got:[0a]AT+FCLASS=2[0d]
06/08 09:27:18 SL0 mdm_command: string 'AT+FCLASS=2'
06/08 09:27:18 SL0 got:[0d][0a]ERROR[0d]
06/08 09:27:18 SL0 mdm_command: string 'ERROR' -> ERROR
06/08 09:27:18 SL0 no class 2/2.0 faxmodem, no faxing available
06/08 09:27:18 SL0 tss: set speed to 115200 (10002)
06/08 09:27:18 SL0 tss: set speed to 115200 (10002)
06/08 09:27:18 SL0 tio_set_flow_control( HARD )
06/08 09:27:18 SL0 detecting voice modem type
06/08 09:27:18 SL0 vgetty: ATE0
06/08 09:27:18 SL0 serial port: ATE0
06/08 09:27:18 SL0 serial port: OK
06/08 09:27:18 SL0 voice command: 'ATI9' -> ''
06/08 09:27:18 SL0 vgetty: ATI9
06/08 09:27:18 SL0 serial port: ERROR
06/08 09:27:19 SL0 voice command: 'ATI3' -> ''
06/08 09:27:19 SL0 vgetty: ATI3
06/08 09:27:19 SL0 serial port: unknown
06/08 09:27:19 SL0 serial port: Smart Link compatible modem
06/08 09:27:19 SL0 serial port: OK
06/08 09:27:19 SL0 voice command: 'ATI' -> ''
06/08 09:27:19 SL0 vgetty: ATI
06/08 09:27:19 SL0 serial port: 56000
06/08 09:27:19 SL0 Rockwell: OK
06/08 09:27:19 SL0 Rockwell detected
06/08 09:27:19 SL0 vgetty: entering voice mode
06/08 09:27:19 SL0 vgetty: Installing signal handlers
06/08 09:27:19 SL0 voice command: 'AT#CLS?' -> ''
06/08 09:27:19 SL0 vgetty: AT#CLS?
06/08 09:27:19 SL0 Rockwell: 0
06/08 09:27:19 SL0 voice command: '' -> 'OK'
06/08 09:27:19 SL0 Rockwell: OK
06/08 09:27:19 SL0 voice command: 'AT#CLS=8' -> 'OK'
06/08 09:27:19 SL0 vgetty: AT#CLS=8
06/08 09:27:19 SL0 Rockwell: OK
06/08 09:27:19 SL0 voice command: 'AT' -> 'OK'
06/08 09:27:19 SL0 vgetty: AT
06/08 09:27:19 SL0 Rockwell: OK
06/08 09:27:19 SL0 vgetty: queued event RESET_WATCHDOG at position
0000
06/08 09:27:19 SL0 initializing ROCKWELL voice modem
06/08 09:27:19 SL0 voice command: 'AT#VSP=70' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT#VSP=70
06/08 09:27:20 SL0 vgetty: unqueued event RESET_WATCHDOG at position
0000
06/08 09:27:20 SL0 vgetty: voice_handle_event got event
RESET_WATCHDOG with data <NUL>
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 voice command: 'AT#TL=8000' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT#TL=8000
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 voice command: 'AT#RG=8000' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT#RG=8000
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 voice command: 'AT#VSD=0' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT#VSD=0
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 voice command: 'AT#VTD=3F,3F,3F' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT#VTD=3F,3F,3F
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 voice command: 'AT#VSS=1' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT#VSS=1
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 voice command: 'AT&K3' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT&K3
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 tio_set_flow_control( HARD )
06/08 09:27:20 SL0 vgetty: leaving voice mode
06/08 09:27:20 SL0 voice command: 'AT#CLS=0' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT#CLS=0
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 voice command: 'AT' -> 'OK'
06/08 09:27:20 SL0 vgetty: AT
06/08 09:27:20 SL0 Rockwell: OK
06/08 09:27:20 SL0 vgetty: Restoring signal handlers
06/08 09:27:20 SL0 waiting for line to clear (VTIME=3), read:
06/08 09:27:21 SL0 removing lock file
06/08 09:27:21 SL0 waiting...
On Tue, 2005-06-07 at 12:40 -0400, George Bell wrote:
> I'm e-mailing my reply off-list as it looks like your problem is
> specifically related to voice only and therefore inappropriate for the
> hylafax mailing list. Looking at your log again you can see there is
> a definite problem:
>
> 06/03 08:18:23 shell(1): DEVICE DIALUP_LINE
> 06/03 08:18:23 vm: queued event RESET_WATCHDOG at position 0003
> 06/03 08:18:23 voice command: 'AT#VLS=4' -> 'OK'
> 06/03 08:18:23 vm: Got pipe signal
> 06/03 08:18:23 vm: queued event SIGNAL_SIGPIPE at position 0004
> 06/03 08:18:23 vm: AT#VLS=4
> 06/03 08:18:23 vm: unqueued event RESET_WATCHDOG at position 0003
> 06/03 08:18:23 vm: voice_handle_event got event RESET_WATCHDOG with
> data <_>
> 06/03 08:18:23 vm: unqueued event SIGNAL_SIGPIPE at position 0004
> 06/03 08:18:23 vm: voice_handle_event got event SIGNAL_SIGPIPE with
> data <NUL>
> 06/03 08:18:23 shell(2): ENABLE EVENTS
> 06/03 08:18:23 vm: Nested command in shell script
> 06/03 08:18:23 vm(2): ERROR
> 06/03 08:18:23 Rockwell: RING
> 06/03 08:18:23 Rockwell:
> 06/03 08:18:23 vm: Got pipe signal
> 06/03 08:18:23 vm: queued event SIGNAL_SIGPIPE at position 0005OK
> 06/03 08:18:23 vm(1): READY
> 06/03 08:18:23 vm: unqueued event SIGNAL_SIGPIPE at position 0005
> 06/03 08:18:23 vm: voice_handle_event got event SIGNAL_SIGPIPE with
> data <NUL>
> 06/03 08:18:23 shell(1): PLAY /var/spool/voice/messages/welcome.rmd
> 06/03 08:18:23 vm(1): PLAYING
> 06/03 08:18:23 playing voice file /var/spool/voice/messages/welcome.rmd
> 06/03 08:18:23 vm: raw modem data header found
> 06/03 08:18:23 vm: modem type Rockwell found
> 06/03 08:18:23 vm: compression method 0x0004, speed 7200, bits 4
> 06/03 08:18:23 vm: queued event RESET_WATCHDOG at position 0006
> 06/03 08:18:23 voice command: 'AT#VBS=4' -> 'OK'
> 06/03 08:18:23 vm: AT#VBS=4
> 06/03 08:18:23 vm: unqueued event RESET_WATCHDOG at position 0006
> 06/03 08:18:23 vm: voice_handle_event got event RESET_WATCHDOG with
> data <NUL>
> 06/03 08:18:23 Rockwell: OK
> 06/03 08:18:23 vm: queued event RESET_WATCHDOG at position 0007
> 06/03 08:18:23 vm: unqueued event RESET_WATCHDOG at position 0007
> 06/03 08:18:23 vm: voice_handle_event got event RESET_WATCHDOG with
> data <NUL>
> 06/03 08:18:23 voice command: 'AT&K3' -> 'OK'
> 06/03 08:18:23 vm: AT&K3
> 06/03 08:18:23 Rockwell: OK
> 06/03 08:18:23 tio_set_flow_control( HARD XON_OUT )
> 06/03 08:18:23 voice command: 'AT#VTX' -> 'CONNECT'
> 06/03 08:18:23 vm: AT#VTX
> 06/03 08:18:23 Rockwell: RING
> 06/03 08:18:28 Rockwell: RING
> 06/03 08:18:33 Rockwell: RING
> 06/03 08:18:38 Rockwell: RING
> 06/03 08:18:44 Rockwell: RING
> 06/03 08:18:49 Rockwell: RING
> 06/03 08:18:54 Rockwell: RING
>
>
> The modem has definitely ignored our command to take it off-hook, as the
> RINGS continue to come in and the failure of this command caused all the
> following commands to fail as well. You mentioned that it works with
> vgetty? Send me the log with vgetty successfully answering the call
> with log level 6 and your {hylafax-root}/etc/config.ttySL0 and I'll take
> one more stab at it. If I can't find out what's going on here you can
> post the log on the mgetty list, mgetty@xxxxxxx
>
> George
--
---------------
Branko Markovic
bramar@xxxxxxxx
ICQ#: 132044291
____________________ HylaFAX(tm) Users Mailing List _______________________
To subscribe/unsubscribe, click http://lists.hylafax.org/cgi-bin/lsg2.cgi
On UNIX: mail -s unsubscribe hylafax-users-request@xxxxxxxxxxx < /dev/null
*To learn about commercial HylaFAX(tm) support, mail sales@xxxxxxxxx*
