Still trouble with voice recording
Bjoern Giesler (bjoern@dominion.inka.de)
Thu, 16 Nov 1995 00:42:44 +0100
Hi,
I kept quiet for a while because I thought I could remove the problem
myself, but it keeps popping up. Voice recordings get cut off because the
modem gets <DLE>s, followed by <DLE>[03]. I am using vgetty from the
mgetty-0.97 distribution; policy.h is appended at the end. The system
is a 486DX2/66 running Linux 1.2.13, the modem is on ttyS2, which is a
16550A, and the modem itself is a ZyXEL U-1496E V6.15.
Anybody know what I'm doing wrong? I am including, as I said, my
policy.h, as well as mgetty.config and an excerpt from the (alas, _very_
verbose) logfile.
Thank you very much in advance.
CU,
Bjoern
--snip-- policy.h --snip--
#ident "@(#)policy.h 1.77 95/06/12 Copyright (c) Gert Doering"
#define MGETTY_CONFIG "mgetty.config"
#define SENDFAX_CONFIG "sendfax.config"
#define LOGIN_CFG_FILE "login.config"
#define DEFAULT_LOGIN_PROGRAM "/bin/login"
/* #define CNDFILE "dialin.config" */
/* #define USE_GETTYDEFS */
#define GETTYDEFS "/etc/gettydefs"
#define GETTYDEFS_DEFAULT_TAG "n"
/* access modes */
#define DEVICE_OWNER "uucp"
#define DEVICE_GROUP "uucp"
#define FILE_MODE 0660
/* #define EXEC_FUSER "exec fuser -k -f %s >/dev/null 2>&1" */
/* logging */
#define CONSOLE "/dev/console"
#define LOG_PATH "/tmp/log_mg.%s"
#define LOG_LEVEL L_MESG
/* #define LOG_CR_NEWLINE */
#define ADMIN "postmaster"
/* #define SYSLOG */
#define SYSLOG_FC LOG_AUTH
/* login stuff */
/* #define SYSTEM "greenie" */
#define LOGIN_PROMPT "@ login: "
/* #define ENV_TTYPROMPT */
#define MAX_LOGIN_TIME 240
#define NOLOGIN_FILE "/etc/nologin.%s"
/* misc */
#define MGETTY_PID_FILE "/etc/mg-pid.%s"
#ifndef LOCK
#define LOCK "/var/spool/uucp/LCK..%s"
#endif
#define LOCKS_BINARY 1
/* #define LOCKS_LOWERCASE */
/* #define LOCKS_ALL_LOWERCASE */
#define DEFAULT_PORTSPEED 38400
#define MODEM_INIT_STRING "ATS0=0Q0&D3&C1"
#define MODEM_CMD_SUFFIX "\r"
#define MODEM_CHECK_TIME 3600
#define DEFAULT_MODEMTYPE "auto"
#define DO_CHAT_SEND_DELAY 50
#define FAX_COMMAND_DELAY 50
#define FAX_IN_OWNER "uucp"
#define FAX_IN_GROUP "uucp"
#define FAX_FILE_MODE 0660
#define DATA_FLOW FLOW_HARD
#define FAXREC_FLOW FLOW_HARD | FLOW_SOFT
#define FAXSEND_FLOW FLOW_HARD | FLOW_SOFT
/* #define FAX_RECV_SWITCHBD 19200 */
/* #define FAX_USRobotics */
#define FAX_LOG "/var/spool/fax/Faxlog"
#define FAX_STATION_ID "49 721 826732"
/* Sendfax stuff */
#define FAX_SEND_BAUD 38400
/* #define FAX_SEND_SWITCHBD 19200 */
/* #define FAX_MODEM_HANDSHAKE "AT&H3" */
#define FAX_DIAL_PREFIX "ATDT"
#define FAX_SEND_MAX_TRIES 3
#define FAX_MODEM_TTYS "modem"
/* #define FAX_SEND_IGNORE_CARRIER */
/* #define FAXSEND_NO_XON */
#ifndef MAILER
# define MAILER "/usr/lib/sendmail"
# define NEED_MAIL_HEADERS
#endif
#define MAIL_TO "bjoern"
#define FAX_NOTIFY_PROGRAM "/usr/local/lib/mgetty+sendfax/new_fax"
#define MINFREESPACE 1024
--snip-- mgetty.config --snip--
port-group uucp
init-chat "" \d+++\dATS0=0Q0&D3&H3&N0&K4L7 OK
--snip-- /tmp/log_mg.modem --snip--
11/15 23:04:33 dem reading configuration data for port 'modem'
11/15 23:04:33 dem conf lib: read: 'port-group uucp'
11/15 23:04:33 dem conf lib: read: 'init-chat ""
\d+++\dATS0=0Q0&D3&H3&N0&K4L7
OK'
11/15 23:04:33 dem key: 'speed', type=0, flags=1, data=38400
11/15 23:04:33 dem key: 'switchbd', type=0, flags=1, data=0
11/15 23:04:33 dem key: 'direct', type=3, flags=1, data=FALSE
11/15 23:04:33 dem key: 'blocking', type=3, flags=1, data=FALSE
11/15 23:04:33 dem key: 'port-owner', type=1, flags=1, data=uucp
11/15 23:04:33 dem key: 'port-group', type=1, flags=3, data=uucp
11/15 23:04:33 dem key: 'port-mode', type=0, flags=1, data=432
11/15 23:04:33 dem key: 'toggle-dtr', type=3, flags=1, data=TRUE
11/15 23:04:33 dem key: 'toggle-dtr-waittime', type=0, flags=1, data=500
11/15 23:04:33 dem key: 'data-only', type=3, flags=1, data=FALSE
11/15 23:04:33 dem key: 'fax-only', type=3, flags=1, data=FALSE
11/15 23:04:33 dem key: 'modem-type', type=1, flags=1, data=auto
11/15 23:04:33 dem key: 'init-chat', type=2, flags=3, data=
\d+++\dATS0=0Q0&D3&
H3&N0&K4L7 OK
11/15 23:04:33 dem key: 'modem-check-time', type=0, flags=1, data=3600
11/15 23:04:33 dem key: 'rings', type=0, flags=2, data=4
11/15 23:04:33 dem key: 'get-cnd-chat', type=2, flags=0, data=(empty)
11/15 23:04:33 dem key: 'answer-chat', type=2, flags=1, data= ATA CONNECT
\c
11/15 23:04:33 dem key: 'answer-chat-timeout', type=0, flags=1, data=80
11/15 23:04:33 dem key: 'autobauding', type=3, flags=1, data=FALSE
11/15 23:04:33 dem key: 'ringback', type=3, flags=1, data=FALSE
11/15 23:04:33 dem key: 'ringback-time', type=0, flags=1, data=30
11/15 23:04:33 dem key: 'issue-file', type=1, flags=1, data=/etc/issue
11/15 23:04:33 dem key: 'prompt-waittime', type=0, flags=1, data=500
11/15 23:04:33 dem key: 'login-prompt', type=1, flags=1, data=@ login:
11/15 23:04:33 dem key: 'login-time', type=0, flags=1, data=240
11/15 23:04:33 dem key: 'fax-id', type=1, flags=1, data=49 721 826732
11/15 23:04:33 dem key: 'fax-server-file', type=1, flags=0, data=(empty)
11/15 23:04:33 dem key: 'diskspace', type=0, flags=1, data=1024
11/15 23:04:33 dem key: 'notify', type=1, flags=1, data=bjoern
11/15 23:04:33 dem key: 'fax-owner', type=1, flags=1, data=uucp
11/15 23:04:33 dem key: 'fax-group', type=1, flags=1, data=uucp
11/15 23:04:33 dem key: 'fax-mode', type=0, flags=1, data=432
11/15 23:04:33 dem key: 'debug', type=0, flags=2, data=9
11/15 23:04:33 dem key: 'statistics-chat', type=2, flags=0, data=(empty)
11/15 23:04:33 dem key: 'statistics-file', type=1, flags=0, data=(empty)
11/15 23:04:33 dem key: 'gettydefs', type=1, flags=1, data=n
11/15 23:04:33 dem key: 'term', type=1, flags=0, data=(empty)
11/15 23:04:33 dem check for lockfiles
11/15 23:04:33 dem checklock: stat failed, no file
11/15 23:04:33 dem locking the line
11/15 23:04:33 dem makelock(modem) called
11/15 23:04:33 dem do_makelock: lock='/var/spool/uucp/LCK..modem'
11/15 23:04:33 dem lock made
11/15 23:04:33 dem lowering DTR to reset Modem
11/15 23:04:34 dem tss: set speed to 38400 (017)
11/15 23:04:34 dem tio_set_flow_control( HARD )
11/15 23:04:34 dem waiting for line to clear (VTIME), read:
11/15 23:04:34 dem send: \d+++\dATS0=0Q0&D3&H3&N0&K4L7[0d]
11/15 23:04:35 dem waiting for `OK''
11/15 23:04:35 dem got: +++ATS0=0Q0&D3&H3&N0&K4L7[0d]
11/15 23:04:35 dem CND: +++ATS0=0Q0&D3&H3&N0&K4L7[0d][0a]OK ** found **
11/15 23:04:35 dem fax_send: 'AT+FCLASS=2.0'
11/15 23:04:35 dem got:[0d][0a]AT+FCLASS=2.0[0d]
11/15 23:04:35 dem mdm_command: string 'AT+FCLASS=2.0'
11/15 23:04:35 dem got:[0d][0a]OK[0d]
11/15 23:04:35 dem mdm_command: string 'OK' -> OK
11/15 23:04:35 dem fax_send: 'AT+FAA=1;+FCR=1'
11/15 23:04:35 dem got:[0a]AT+FAA=1;+FCR=1[0d]
11/15 23:04:35 dem mdm_command: string 'AT+FAA=1;+FCR=1'
11/15 23:04:35 dem got:[0d][0a]OK[0d]
11/15 23:04:35 dem mdm_command: string 'OK' -> OK
11/15 23:04:35 dem fax_send: 'AT+FBO=1'
11/15 23:04:35 dem got:[0a]AT+FBO=1[0d]
11/15 23:04:35 dem mdm_command: string 'AT+FBO=1'
11/15 23:04:35 dem got:[0d][0a]OK[0d]
11/15 23:04:35 dem mdm_command: string 'OK' -> OK
11/15 23:04:35 dem fax_send: 'AT+FNR=1,1,1,0'
11/15 23:04:35 dem got:[0a]AT+FNR=1,1,1,0[0d]
11/15 23:04:35 dem mdm_command: string 'AT+FNR=1,1,1,0'
11/15 23:04:35 dem got:[0d][0a]OK[0d]
11/15 23:04:35 dem mdm_command: string 'OK' -> OK
11/15 23:04:35 dem fax_send: 'AT+FLI="49 721 826732"'
11/15 23:04:35 dem got:[0a]AT+FLI="49 721 826732"[0d]
11/15 23:04:35 dem mdm_command: string 'AT+FLI="49 721 826732"'
11/15 23:04:35 dem got:[0d][0a]OK[0d]
11/15 23:04:35 dem mdm_command: string 'OK' -> OK
11/15 23:04:36 dem fax_send: 'AT+FCC=1,5,0,2,0,0,0,0'
11/15 23:04:36 dem got:[0a]AT+FCC=1,5,0,2,0,0,0,0[0d]
11/15 23:04:36 dem mdm_command: string 'AT+FCC=1,5,0,2,0,0,0,0'
11/15 23:04:36 dem got:[0d][0a]OK[0d]
11/15 23:04:36 dem mdm_command: string 'OK' -> OK
11/15 23:04:36 dem vgetty: experimental test release 0.23 / 12Apr95
11/15 23:04:36 dem mgetty: official release 0.98
11/15 23:04:36 dem voice_command: send 'AT+FCLASS=8'
11/15 23:04:36 dem voice_wait_for(VCON|OK)
11/15 23:04:36 dem got:AT+FCLASS=8[0d][0a]
11/15 23:04:36 dem voice_wait_for: string 'AT+FCLASS=8'
11/15 23:04:36 dem got:[0d][0a]OK[0d][0a]
11/15 23:04:36 dem voice_wait_for: string 'OK'** found **
11/15 23:04:36 dem voice_command: send 'ATI'
11/15 23:04:36 dem voice_wait_for(1496|2864|OK)
11/15 23:04:36 dem got:ATI[0d][0a]
11/15 23:04:36 dem voice_wait_for: string 'ATI'
11/15 23:04:36 dem got:[0d][0a]1496[0d][0a]
11/15 23:04:36 dem voice_wait_for: string '1496'** found **
11/15 23:04:36 dem voice_command: send ''
11/15 23:04:36 dem voice_wait_for(OK)
11/15 23:04:36 dem got:[0d][0a]OK[0d][0a]
11/15 23:04:36 dem voice_wait_for: string 'OK'** found **
11/15 23:04:36 dem modem type ZyXEL
11/15 23:04:36 dem voice_command: send 'ATS0=0'
11/15 23:04:36 dem voice_wait_for(OK)
11/15 23:04:36 dem got:[0d][0a]ATS0=0[0d][0a]
11/15 23:04:36 dem voice_wait_for: string 'ATS0=0'
11/15 23:04:36 dem got:[0d][0a]OK[0d][0a]
11/15 23:04:36 dem voice_wait_for: string 'OK'** found **
11/15 23:04:36 dem waiting for line to clear (VTIME), read:
11/15 23:04:36 dem removing lock file
11/15 23:04:36 dem waiting...
11/15 23:08:50 dem select returned 1
11/15 23:08:50 dem checking lockfiles, locking the line
11/15 23:08:50 dem makelock(modem) called
11/15 23:08:50 dem do_makelock: lock='/var/spool/uucp/LCK..modem'
11/15 23:08:50 dem lock made
11/15 23:08:50 dem waiting for `RING^M''
11/15 23:08:50 dem got: [0d]
11/15 23:08:50 dem CND: OK[0a]RING[0d]
11/15 23:08:50 dem CND: RING ** found **
11/15 23:08:50 dem waiting for `RING^M''
11/15 23:08:50 dem got: [0a][0d][0a]RING[0d]
11/15 23:08:56 dem CND: RING ** found **
11/15 23:08:56 dem waiting for `RING^M''
11/15 23:08:56 dem got: [0a][0d][0a]RING[0d]
11/15 23:09:03 dem CND: RING ** found **
11/15 23:09:03 dem waiting for `RING^M''
11/15 23:09:03 dem got: [0a][0d][0a]RING[0d]
11/15 23:09:09 dem CND: RING ** found **
11/15 23:09:09 dem send: ATA[0d]
11/15 23:09:09 dem waiting for `VCON''
11/15 23:09:09 dem got: [0a]ATA[0d]
11/15 23:09:09 dem CND: ATA[0d][0a]VCON ** found **
11/15 23:09:09 dem found 1 messages
11/15 23:09:09 dem picked file /var/spool/voice/messages/robot.deutsch
11/15 23:09:09 dem voice_send_file("/var/spool/voice/messages/robot.deutsch") s
tarted...
11/15 23:09:09 dem sending /var/spool/voice/messages/robot.deutsch...
11/15 23:09:09 dem reading zfax header, compression type 3
11/15 23:09:09 dem tio_set_flow_control( HARD )
11/15 23:09:09 dem voice_command: send 'ATS39.7=0 S39.6=1 +VIT=60'
11/15 23:09:09 dem voice_wait_for(VCON|OK)
11/15 23:09:09 dem got:[0d][0a]ATS39.7=0 S39.6=1 +VIT=60[0d]\376[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'ATS39.7=0 S39.6=1 +VIT=60\376'
11/15 23:09:09 dem got:OK[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'OK'** found **
11/15 23:09:09 dem voice_command: send 'AT+VDH=12 +VDD=6'
11/15 23:09:09 dem voice_wait_for(VCON|OK)
11/15 23:09:09 dem got:AT+VDH=12 +VDD=6[0d]\376[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'AT+VDH=12 +VDD=6\376'
11/15 23:09:09 dem got:OK[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'OK'** found **
11/15 23:09:09 dem voice_command: send 'AT+FLO=2'
11/15 23:09:09 dem voice_wait_for(VCON|OK)
11/15 23:09:09 dem got:AT+FLO=2[0d]\376[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'AT+FLO=2\376'
11/15 23:09:09 dem got:OK[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'OK'** found **
11/15 23:09:09 dem voice_command: send 'ATL7'
11/15 23:09:09 dem voice_wait_for(VCON|OK)
11/15 23:09:09 dem got:ATL7[0d]\376[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'ATL7\376'
11/15 23:09:09 dem got:OK[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'OK'** found **
11/15 23:09:09 dem voice_command: send 'AT+VSM=3 +VLS=2'
11/15 23:09:09 dem voice_wait_for(VCON|OK)
11/15 23:09:09 dem got:AT+VSM=3 +VLS=2[0d]\376[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'AT+VSM=3 +VLS=2\376'
11/15 23:09:09 dem got:VCON[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'VCON'** found **
11/15 23:09:09 dem voice_command: send 'AT+VTX'
11/15 23:09:09 dem voice_wait_for(CONNECT)
11/15 23:09:09 dem got:AT+VTX[0d]\376[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'AT+VTX\376'
11/15 23:09:09 dem got:CONNECT[0d][0a]
11/15 23:09:09 dem voice_wait_for: string 'CONNECT'** found **
11/15 23:09:09 dem read 1024, write 1033
[loads of 'read 1024, write xxxx' snipped]
11/15 23:09:29 dem read 56, write 59
11/15 23:09:29 dem sending DLE ETX...
11/15 23:09:29 dem voice_wait_for(VCON|OK)
11/15 23:09:29 dem got:[0d][0a]VCON[0d][0a]
11/15 23:09:30 dem voice_wait_for: string 'VCON'** found **
11/15 23:09:30 dem voice_send_file returned 's'
11/15 23:09:30 dem voice_command: send 'ATL7'
11/15 23:09:30 dem voice_wait_for(VCON|OK)
11/15 23:09:30 dem got:ATL7[0d]\376[0d][0a]
11/15 23:09:30 dem voice_wait_for: string 'ATL7\376'
11/15 23:09:30 dem got:OK[0d][0a]
11/15 23:09:30 dem voice_wait_for: string 'OK'** found **
11/15 23:09:30 dem voice_command: send 'AT+VLS=2'
11/15 23:09:30 dem voice_wait_for(VCON|OK)
11/15 23:09:30 dem got:AT+VLS=2[0d]\376[0d][0a]
11/15 23:09:30 dem voice_wait_for: string 'AT+VLS=2\376'
11/15 23:09:30 dem got:VCON[0d][0a]
11/15 23:09:30 dem voice_wait_for: string 'VCON'** found **
11/15 23:09:30 dem voice_command: send 'AT+VTS=[933,0,12]'
11/15 23:09:31 dem voice_wait_for(VCON|OK)
11/15 23:09:31 dem got:AT+VTS=[933,0,12][0d]\376[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'AT+VTS=[933,0,12]\376'
11/15 23:09:32 dem got:OK[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'OK'** found **
11/15 23:09:32 dem tio_set_flow_control( HARD )
11/15 23:09:32 dem voice_command: send 'ATS39.7=0 S39.6=1 +VIT=60'
11/15 23:09:32 dem voice_wait_for(VCON|OK)
11/15 23:09:32 dem got:ATS39.7=0 S39.6=1 +VIT=60[0d]\376[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'ATS39.7=0 S39.6=1 +VIT=60\376'
11/15 23:09:32 dem got:OK[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'OK'** found **
11/15 23:09:32 dem voice_command: send 'AT+VDH=12 +VDD=6'
11/15 23:09:32 dem voice_wait_for(VCON|OK)
11/15 23:09:32 dem got:AT+VDH=12 +VDD=6[0d]\376[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'AT+VDH=12 +VDD=6\376'
11/15 23:09:32 dem got:OK[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'OK'** found **
11/15 23:09:32 dem voice_command: send 'AT+FLO=2'
11/15 23:09:32 dem voice_wait_for(VCON|OK)
11/15 23:09:32 dem got:AT+FLO=2[0d]\376[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'AT+FLO=2\376'
11/15 23:09:32 dem got:OK[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'OK'** found **
11/15 23:09:32 dem voice_command: send 'ATL7'
11/15 23:09:32 dem voice_wait_for(VCON|OK)
11/15 23:09:32 dem got:ATL7[0d]\376[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'ATL7\376'
11/15 23:09:32 dem got:OK[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'OK'** found **
11/15 23:09:32 dem voice_command: send 'AT+VSM=3 +VLS=2 +VSD=12,70'
11/15 23:09:32 dem voice_wait_for(VCON|OK)
11/15 23:09:32 dem got:AT+VSM=3 +VLS=2 +VSD=12,70[0d]\376[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'AT+VSM=3 +VLS=2 +VSD=12,70\376'
11/15 23:09:32 dem got:VCON[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'VCON'** found **
11/15 23:09:32 dem voice_command: send 'AT+VRX'
11/15 23:09:32 dem voice_wait_for(CONNECT)
11/15 23:09:32 dem got:AT+VRX[0d]\376[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'AT+VRX\376'
11/15 23:09:32 dem got:CONNECT[0d][0a]
11/15 23:09:32 dem voice_wait_for: string 'CONNECT'** found **
[Here we go:]
11/15 23:09:32 dem voice_record: receiving /var/spool/voice/incoming/voc-a01740
...
11/15 23:09:40 dem input: got <DLE>s
[What's this?]
11/15 23:09:40 dem voice_send: 'Q'
11/15 23:09:40 dem input: got <DLE>[03]
11/15 23:09:40 dem got DLE ETX
11/15 23:09:40 dem voice record: end, bytes received: 25243
11/15 23:09:40 dem voice_command: send ''
11/15 23:09:40 dem voice_wait_for(VCON|OK)
11/15 23:09:40 dem got:[0d][0a]VCON[0d][0a]
11/15 23:09:40 dem voice_wait_for: string 'VCON'** found **
11/15 23:09:40 dem voice_record_file returned 's'
11/15 23:09:40 dem removing recording.
11/15 23:09:40 dem Trying fax/data connection...
11/15 23:09:40 dem voice_command: send 'AT+FCLASS=2.0;+FAA=1'
11/15 23:09:40 dem voice_wait_for(OK)
11/15 23:09:40 dem got:[0d][0a]AT+FCLASS=2.0;+FAA=1[0d]\376[0d][0a]
11/15 23:09:40 dem voice_wait_for: string 'AT+FCLASS=2.0;+FAA=1\376'
11/15 23:09:40 dem got:OK[0d][0a]
11/15 23:09:40 dem voice_wait_for: string 'OK'** found **
11/15 23:09:40 dem fax_send: 'AT+FBO=1'
11/15 23:09:40 dem got:[0a]AT+FBO=1[0d]
11/15 23:09:40 dem mdm_command: string 'AT+FBO=1'
11/15 23:09:40 dem got:[0d][0a]OK[0d]
11/15 23:09:40 dem mdm_command: string 'OK' -> OK
11/15 23:09:40 dem send: ATA[0d]
11/15 23:09:40 dem waiting for `CONNECT''
11/15 23:09:40 dem got: ATA[0d]
11/15 23:09:40 dem CND: VCONATA[0d][0a]NO CARRIER
11/15 23:10:18 dem found action string: `NO CARRIER''
11/15 23:10:18 ##### failed A_FAIL dev=modem, pid=1740, caller=none, conn='', na
me=''
11/15 23:10:18 dem removing lock file
--snip-- --snip--
--
Bjoern Giesler o There's got to be a pill
o for forgiveness
o There's got to be a trigger