I believe the problem I am experiencing has something to do with the
Modem drivers and how Kannel handles the message queue when the Modem
receives an incoming message. Please inform if this should be posted to
the devel list instead.
If I can't fix this with configuration directives, is there a way to
detect the failures and resend them?
************************************************************************
****
SETUP
************************************************************************
****
Debian Linux 3.0 (Woody)
Linux Kernel 2.4.23
Kannel 1.3.1-4 (Debian Package: kannel-devel)
Wavecom FastTrack GSM Modem: M1213A-ON
************************************************************************
****
************************************************************************
****
CONFIGURATION
************************************************************************
****
group = core
admin-port = 13000
admin-password = ********
admin-deny-ip = "*.*.*.*"
admin-allow-ip = "192.168.1.*;65.36.154.35"
smsbox-port = 13001
log-file = "/var/log/kannel/bearerbox.log"
box-deny-ip = "*.*.*.*"
box-allow-ip = "192.168.1.*;65.36.154.35;127.0.0.1"
#SMSC CONNECTIONS
group = smsc
smsc = at2
smsc-id = 16195192314
modemtype = wavecom
device = /dev/ttyS0
#MODEM DEFINITIONS
group = modems
id = wavecom
name = Wavecom
detect-string = "WAVECOM"
init-string = "AT+CNMI=2,2,0,1,0"
sendline-sleep = 200
keepalive-cmd = "AT+CSQ"
#SMSBOX SETUP
group = smsbox
bearerbox-host = localhost
sendsms-port = 13013
log-file = "/var/log/kannel/smsbox.log"
#SEND-SMS USERS
group = sendsms-user
username = ******
password = ******
# this sender is for Kannel relay testing (http_smsc)
group = sendsms-user
username = ******
password = ******
user-deny-ip = "*.*.*.*"
user-allow-ip = "127.0.0.1"
# SERVICES
group = sms-service
keyword = nop
text = "You asked nothing and I did it!"
# this service is for Kannel relay testing, when this Kannel
# works as relay gateway
group = sms-service
keyword = dtown
aliases = DTOWN;Dtown
get-url =
"http://www.2chatter.com/parseSMS/dtown.php?sender=%p&smsprefix=%k&sms=%
s%r&fullsms=%a&recip=%P"
max-messages = 1
catch-all = true
group = sms-service
keyword = downtown
aliases = DOWNTOWN;Downtown
get-url =
"http://www.2chatter.com/parseSMS/downtown.php?sender=%p&smsprefix=%k&sm
s=%s%r&fullsms=%a&recip=%P"
max-messages = 1
catch-all = true
group = sms-service
keyword = pickup
aliases = PICKUP;Pickup
get-url =
"http://www.2chatter.com/ams/pickup.php?sender=%p&smsprefix=%k&sms=%s%r&
fullsms=%a&recip=%P"
max-messages = 1
catch-all = true
group = sms-service
keyword = deliver
aliases = DELIVER;Deliver
get-url =
"http://www.2chatter.com/ams/deliver.php?sender=%p&smsprefix=%k&sms=%s%r
&fullsms=%a&recip=%P"
max-messages = 1
catch-all = true
# there should be default always
group = sms-service
keyword = default
get-url =
"http://www.2chatter.com/parseSMS/default.php?sender=%p&smsprefix=%k&sms
=%s%r&fullsms=%a&recip=%P"
max-messages = 1
catch-all = true
************************************************************************
****
************************************************************************
****
LOG
I
At 2004-01-29 10:38:21 you can see a message received by the GSM modem.
After that, errors start to occur. It appears as though one message did
get sent at 2004-01-29 10:38:23
************************************************************************
****
2004-01-29 10:38:00 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:00 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:00 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:00 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:00 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:00 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:00 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:01 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:01 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:01 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:01 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:01 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:01 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:01 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:01 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:01 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 121
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:03 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:06 [2] DEBUG: HTTP: Creating HTTPClient for
`65.36.154.35'.
2004-01-29 10:38:06 [3] DEBUG: HTTP: Destroying HTTPClient area
0x80f8128.
2004-01-29 10:38:06 [3] DEBUG: HTTP: Destroying HTTPClient for
`65.36.154.35'.
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 122
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:06 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 123
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:09 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 124
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:12 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 125
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:15 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:17 [2] DEBUG: HTTP: Creating HTTPClient for
`65.36.154.35'.
2004-01-29 10:38:17 [3] DEBUG: HTTP: Destroying HTTPClient area
0x80f8910.
2004-01-29 10:38:17 [3] DEBUG: HTTP: Destroying HTTPClient for
`65.36.154.35'.
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 126
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:18 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 127
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: <-- +CMT: ,23
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: <--
07912160130300F4040B916191152913F2000040109201838540044CE67308
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: Numeric sender
(international) <+16195192312>
2004-01-29 10:38:21 [5] DEBUG: AT2[16195192314]: --> AT+CNMA^M
2004-01-29 10:38:21 [8] DEBUG: send_msg: sending msg to boxc: <(null)>
2004-01-29 10:38:21 [8] DEBUG: boxc_sender: sent message to <127.0.0.1>
2004-01-29 10:38:21 [7] DEBUG: boxc_receiver: got ack
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:22 [7] DEBUG: boxc_receiver: sms received
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:22 [2] DEBUG: HTTP: Creating HTTPClient for
`65.36.154.35'.
2004-01-29 10:38:22 [3] DEBUG: HTTP: Destroying HTTPClient area
0x80f87a0.
2004-01-29 10:38:22 [3] DEBUG: HTTP: Destroying HTTPClient for
`65.36.154.35'.
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:22 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=17^M
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: -->
0011000A8116895681670000A704F4F29C0E
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 128
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: <-- OK
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: send command status: 0
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2004-01-29 10:38:23 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=133^M
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: send command status: 1
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: -->
0011000B916191152913F20000A787547419344487E9F4B21C342FCBED6539889C2683DC
6F3AA8EE2697E5737AD84D06E5DF7539A85D9ECFC3E7B20B046597C3F332688C2E8FD720
3ABA0C6A97E7F3F0B90C0ABBC920BA3C0F0A9FC36937E82D078DC36C36A83E0785E9205B
2CD7AAD16CAD1C0E367381EEF7BB4B364687E9F4B2DC357EB701
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: --> ^Z
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: <-- >
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=133^M
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:24 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=133^M
2004-01-29 10:38:25 [5] DEBUG: AT2[16195192314]: <--
2004-01-29 10:38:25 [5] DEBUG: AT2[16195192314]: <-- ERROR
2004-01-29 10:38:25 [5] DEBUG: AT2[16195192314]: send command status: -1
2004-01-29 10:38:25 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 129
2004-01-29 10:38:25 [5] DEBUG: AT2[16195192314]: <-- OK
************************************************************************
****
Nicholas Calugar
619-546-9803
866-404-2428
Chatter
3577 4th Ave.
San Diego, CA 92103
www.2chatter.com