Voice problems with 2834ZDXv

Alan Jeffrey (ajeffrey@cs.depaul.edu)
Tue, 27 Oct 1998 18:28:54 +0100


This is a multi-part message in MIME format.
--------------FD42B0EB89C0DD72E2894C50
Content-Type: text/plain; charset=us-ascii
Content-Transfer-Encoding: 7bit

Hi there,

I hope someone can help me with getting voice up and running on my
2834ZDXv connected to a RH5.0 box running mgetty/vgetty v1.1.18.

Fax/data are working fine.  With voice, if I record a message using vm
(or phoning in to vgetty) and play it back, then I get about a second of
poor-quality sound, and the rest of the recording is silent.  Using
playback also often gets the modem into a state where only a power cycle
will restore it to sanity.

Two log files are attatched, one for recording and one for playback.

Any help gratefully received!

Alan
--
Alan Jeffrey  CTI, DePaul University, 243 S Wabash, Chicago IL 60604,
USA
ajeffrey@cs.depaul.edu               
http://klee.cs.depaul.edu/ajeffrey/
--------------FD42B0EB89C0DD72E2894C50
Content-Type: text/plain; charset=us-ascii;
 name="vm-rec.log"
Content-Transfer-Encoding: 7bit
Content-Disposition: inline;
 filename="vm-rec.log"


10/26 18:34:41  vgetty: experimental test release 0.9.0 / 09Sep98

...

10/26 18:34:46  recording voice file /tmp/foo
10/26 18:34:46    vm: queued event RESET_WATCHDOG at position 0002
10/26 18:34:46   voice command: 'AT+VSM=2,8000' -> 'OK'
10/26 18:34:46    vm: AT+VSM=2,8000
10/26 18:34:46    vm: unqueued event RESET_WATCHDOG at position 0002
10/26 18:34:46    vm: voice_handle_event got event RESET_WATCHDOG with data <_>
10/26 18:34:46    Multitech 2834ZDXv: AT+VSM=2,8000
10/26 18:34:46    Multitech 2834ZDXv: OK
10/26 18:34:46    vm: queued event RESET_WATCHDOG at position 0003
10/26 18:34:46    vm: unqueued event RESET_WATCHDOG at position 0003
10/26 18:34:46    vm: voice_handle_event got event RESET_WATCHDOG with data <_>
10/26 18:34:46   voice command: 'AT+FLO=2' -> 'OK'
10/26 18:34:46    vm: AT+FLO=2
10/26 18:34:46    Multitech 2834ZDXv: AT+FLO=2
10/26 18:34:46    Multitech 2834ZDXv: OK
10/26 18:34:46   tio_set_flow_control( HARD XON_IN )
10/26 18:34:46   voice command: 'AT+VRX' -> 'CONNECT'
10/26 18:34:46    vm: AT+VRX
10/26 18:34:46    Multitech 2834ZDXv: AT+VRX
10/26 18:34:46    Multitech 2834ZDXv: CONNECT
10/26 18:34:47    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:47  vm: Unknown code <DLE> <_>
10/26 18:34:47    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:47  vm: Unknown code <DLE> <_>
10/26 18:34:47    Multitech 2834ZDXv: <DLE> <;>
10/26 18:34:47  vm: Unknown code <DLE> <;>
10/26 18:34:47    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:47  vm: Unknown code <DLE> <_>
10/26 18:34:47    Multitech 2834ZDXv: <DLE> <
10/26 18:34:47  vm: Unknown code <DLE> <
10/26 18:34:47    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:47  vm: Unknown code <DLE> <_>
10/26 18:34:48    Multitech 2834ZDXv: <DLE> <l>
10/26 18:34:48  vm: Unknown code <DLE> <l>
10/26 18:34:48    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:48  vm: Unknown code <DLE> <_>
10/26 18:34:48    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:48  vm: Unknown code <DLE> <_>
10/26 18:34:48    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:48  vm: Unknown code <DLE> <_>
10/26 18:34:48    Multitech 2834ZDXv: <DLE> <H>
10/26 18:34:48    vm: queued event HANDSET_OFF_HOOK at position 0004
10/26 18:34:48    vm: unqueued event HANDSET_OFF_HOOK at position 0004
10/26 18:34:48    vm: voice_handle_event got event HANDSET_OFF_HOOK with data <_>
10/26 18:34:48    Multitech 2834ZDXv: <DLE> <h>
10/26 18:34:48    vm: queued event HANDSET_ON_HOOK at position 0005
10/26 18:34:48    vm: unqueued event HANDSET_ON_HOOK at position 0005
10/26 18:34:48    vm: voice_handle_event got event HANDSET_ON_HOOK with data <_>
10/26 18:34:49    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:49  vm: Unknown code <DLE> <_>
10/26 18:34:49    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:49  vm: Unknown code <DLE> <_>
10/26 18:34:49    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:49  vm: Unknown code <DLE> <_>
10/26 18:34:49    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:49  vm: Unknown code <DLE> <_>
10/26 18:34:49    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:49  vm: Unknown code <DLE> <_>
10/26 18:34:49    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:49  vm: Unknown code <DLE> <_>
10/26 18:34:49    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:49  vm: Unknown code <DLE> <_>
10/26 18:34:50    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:50  vm: Unknown code <DLE> <_>
10/26 18:34:50    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:50  vm: Unknown code <DLE> <_>
10/26 18:34:50    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:50  vm: Unknown code <DLE> <_>
10/26 18:34:50    Multitech 2834ZDXv: <DLE> <p>
10/26 18:34:50    vm: queued event HANDSET_ON_HOOK at position 0006
10/26 18:34:50    vm: unqueued event HANDSET_ON_HOOK at position 0006
10/26 18:34:50    vm: voice_handle_event got event HANDSET_ON_HOOK with data <_>
10/26 18:34:50    Multitech 2834ZDXv: <DLE> <">
10/26 18:34:50  vm: Unknown code <DLE> <">
10/26 18:34:50    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:50  vm: Unknown code <DLE> <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:51  vm: Unknown code <DLE> <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <9>
10/26 18:34:51    vm: queued event RECEIVED_DTMF at position 0007
10/26 18:34:51    vm: unqueued event RECEIVED_DTMF at position 0007
10/26 18:34:51    vm: voice_handle_event got event RECEIVED_DTMF with data <9>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:51  vm: Unknown code <DLE> <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:51  vm: Unknown code <DLE> <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:51  vm: Unknown code <DLE> <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:51  vm: Unknown code <DLE> <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <J>
10/26 18:34:51    vm: queued event SIT_TONE at position 0008
10/26 18:34:51    vm: unqueued event SIT_TONE at position 0008
10/26 18:34:51    vm: voice_handle_event got event SIT_TONE with data <_>
10/26 18:34:51  vm: voice_handle_event got unknown event SIT_TONE with data <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <_>
10/26 18:34:51  vm: Unknown code <DLE> <_>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <K>
10/26 18:34:51    vm: queued event BUSY_TONE at position 0009
10/26 18:34:51    vm: unqueued event BUSY_TONE at position 0009
10/26 18:34:51    vm: voice_handle_event got event BUSY_TONE with data <_>
10/26 18:34:51    vm: <STOP RECORDING>
10/26 18:34:51    Multitech 2834ZDXv: <VOICE DATA 16868 bytes>
10/26 18:34:51    Multitech 2834ZDXv: <DLE> <ETX>
10/26 18:34:51   voice command: '' -> 'OK'
10/26 18:34:51    Multitech 2834ZDXv: OK
10/26 18:34:51    vm: queued event RESET_WATCHDOG at position 0010
10/26 18:34:51   voice command: 'AT+VLS=0' -> 'OK'
10/26 18:34:52    vm: AT+VLS=0
10/26 18:34:52    vm: unqueued event RESET_WATCHDOG at position 0010
10/26 18:34:52    vm: voice_handle_event got event RESET_WATCHDOG with data <_>
10/26 18:34:52    Multitech 2834ZDXv: AT+VLS=0
10/26 18:34:52    Multitech 2834ZDXv: OK
10/26 18:34:52   vm: leaving voice mode
10/26 18:34:52   voice command: 'AT+FCLASS=0' -> 'OK'
10/26 18:34:52    vm: AT+FCLASS=0
10/26 18:34:52    Multitech 2834ZDXv: AT+FCLASS=0
10/26 18:34:52    Multitech 2834ZDXv: OK
10/26 18:34:52    vm: AT
10/26 18:34:52    Multitech 2834ZDXv: AT
10/26 18:34:52  vm: Modem answered correctly - mail rmk@arm.uk.linux.org
10/26 18:34:52   vm: Restoring signal handlers
10/26 18:34:52  closing voice modem device
10/26 18:34:52   removing lock file
--------------FD42B0EB89C0DD72E2894C50
Content-Type: text/plain; charset=us-ascii;
 name="vm-play.log"
Content-Transfer-Encoding: 7bit
Content-Disposition: inline;
 filename="vm-play.log"


10/26 18:36:14  vgetty: experimental test release 0.9.0 / 09Sep98

...

10/26 18:36:18  playing voice file /tmp/foo
10/26 18:36:18   vm: raw modem data header found
10/26 18:36:18   vm: modem type Multitech2834 found
10/26 18:36:18   vm: compression method 0x0004, speed 8000, bits 4
10/26 18:36:18    vm: queued event RESET_WATCHDOG at position 0002
10/26 18:36:18   voice command: 'AT+VSM=2,8000' -> 'OK'
10/26 18:36:18    vm: AT+VSM=2,8000
10/26 18:36:18    vm: unqueued event RESET_WATCHDOG at position 0002
10/26 18:36:18    vm: voice_handle_event got event RESET_WATCHDOG with data <_>
10/26 18:36:18    Multitech 2834ZDXv: AT+VSM=2,8000
10/26 18:36:18    Multitech 2834ZDXv: OK
10/26 18:36:18    vm: queued event RESET_WATCHDOG at position 0003
10/26 18:36:18    vm: unqueued event RESET_WATCHDOG at position 0003
10/26 18:36:18    vm: voice_handle_event got event RESET_WATCHDOG with data <_>
10/26 18:36:18   voice command: 'AT+FLO=2' -> 'OK'
10/26 18:36:18    vm: AT+FLO=2
10/26 18:36:18    Multitech 2834ZDXv: AT+FLO=2
10/26 18:36:19    Multitech 2834ZDXv: OK
10/26 18:36:19   tio_set_flow_control( HARD XON_OUT )
10/26 18:36:19   voice command: 'AT+VTX' -> 'CONNECT'
10/26 18:36:19    vm: AT+VTX
10/26 18:36:19    Multitech 2834ZDXv: AT+VTX
10/26 18:36:19    Multitech 2834ZDXv: CONNECT
10/26 18:36:31    Multitech 2834ZDXv: <DLE> <_>
10/26 18:36:31  vm: <DLE> <ETX> received
10/26 18:36:31  vm: unexpected byte _ from voice modem
10/26 18:36:31  vm: unexpected byte _ from voice modem
10/26 18:36:31  vm: unexpected byte O from voice modem
10/26 18:36:31  vm: unexpected byte K from voice modem
10/26 18:36:31  vm: unexpected byte _ from voice modem

... lots more unexpected bytes ...

10/26 18:36:32  vm: unexpected byte < from voice modem
10/26 18:36:32  vm: unexpected byte _ from voice modem
10/26 18:36:32    vm: <VOICE DATA 16809 bytes>
10/26 18:36:32    vm: queued event RESET_WATCHDOG at position 0004
10/26 18:36:32    vm: unqueued event RESET_WATCHDOG at position 0004
10/26 18:36:32    vm: voice_handle_event got event RESET_WATCHDOG with data <_>
10/26 18:36:32    vm: <STOP PLAY>
10/26 18:36:32   voice command: '' -> 'OK'
10/26 18:36:32    Multitech 2834ZDXv: [06][fc][06]<[f8][e6][e0]f[cc][80][00][c0][06]<[ff][e6][e0][18][03]x[00][f8][80][80][00][80][80][80][00]"[fb][04][06]<[ff][e6][e0][e0][fe][b2][f9][e1]A[fc][e6][80][00][f8]A[fe]r[f1]x[fc][00][00][80][f8][06][fc]x[fc][00][00][f8][8d][c0][06]<[ff][06][fc][f6]x[fc][00][f8][00][f8][06]<[06][fc][f8]x[00][b2][ff][c1][fe][06][fc][fe]a[fe])x[00][f8][e6][e0]f[cc][8d]dx[fc][00][00][80][f8]([06]<[a8][fc][ca][e6][e0][e6][f8][e6][e0]f[cc][8d]uAA[fd]x[00][f8][c1][f5]x[fc][00]x[00][80][8d][d6]A[e1][ff][8d]j[06]0[ff][06][fc][06][fc][06][f0][fe]A[fc]2[fb][83][a8][c1][fe]AA[f9]x[fc][00][f8][80][80][06][f0]A[fd][06]0[ff]x[00][f8][e1][ff][a2][ff][b2][fb][06][f0][ff][80][00][80][e6][e0][fe][e0]x[fc][00]x<[f0][80][06]<`[ff][e0][98][9e][9e][80][9e][9e]x[f0][f3][86][1e][fc][f3][e0][e0][06]?f[03][18][c3]x[00][fe][e6]f[c0][00][f8][8a]O[cb][8a][e6][80][f8][e6][06]<[f8][8d][ad]
10/26 18:36:33  vm: Invalid modem answer
10/26 18:36:33    Multitech 2834ZDXv: _<[b2][fc][c1][f9][06]0[f8][06][fc][f0][c1][fb][8d][01][06][fc][f8]
10/26 18:36:33  vm: stop_play_file command failed
10/26 18:36:33    vm: queued event RESET_WATCHDOG at position 0005
10/26 18:36:33   voice command: 'AT+VLS=0' -> 'OK'
10/26 18:36:33    vm: AT+VLS=0
10/26 18:36:33    vm: unqueued event RESET_WATCHDOG at position 0005
10/26 18:36:33    vm: voice_handle_event got event RESET_WATCHDOG with data <_>
10/26 18:36:33    Multitech 2834ZDXv: AT+VLS=0
10/26 18:36:34    Multitech 2834ZDXv: OK
10/26 18:36:34   vm: leaving voice mode
10/26 18:36:34   voice command: 'AT+FCLASS=0' -> 'OK'
10/26 18:36:34    vm: AT+FCLASS=0
10/26 18:36:34    Multitech 2834ZDXv: AT+FCLASS=0
10/26 18:36:34    Multitech 2834ZDXv: OK
10/26 18:36:34    vm: AT
10/26 18:36:34    Multitech 2834ZDXv: AT
10/26 18:36:34  vm: Modem answered correctly - mail rmk@arm.uk.linux.org
10/26 18:36:34   vm: Restoring signal handlers
10/26 18:36:34  closing voice modem device
10/26 18:36:34   removing lock file
--------------FD42B0EB89C0DD72E2894C50--