Instead of using the version installed by apt-get, I downloaded the
debian package of kannel v1.2.1. I installed it and changed the
configuration file to use the "at2" modem driver instead of the "at"
driver. It sent out a little over one hundred messages but then failed,
however, it recovered several times and sent the message.

This is the bearerbox log showing the first two messages sending
successfully and some interleaved messages showing the bearerbox
receiving from the smsbox:
------------------------------------------------------------------------
----2003-12-15 11:21:10 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2003-12-15 11:21:10 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:21:10 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:21:10 [5] DEBUG: AT2[16195192314]: send command status: 1
2003-12-15 11:21:10 [5] DEBUG: AT2[16195192314]: -->
0011000B818185435411F30000A78050E9935A1C5241D967553A2D328DA0A09308CA3EAB
529031D84C32B33A90915D074DD16FFA1C14769341CDF49C0E0ACBCBA0393DCD6683C2F6
709A1D16B3CBA0301D34A3CD6AA061B89D76BF41C4321B244DBF4153170B34ADA7E96590
0C8673818661361B648BE55AB81AAE15BBC162
2003-12-15 11:21:10 [5] DEBUG: AT2[16195192314]: --> ^Z
2003-12-15 11:21:11 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:12 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 213
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: <-- OK
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: send command status: 0
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: send command status: 1
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: -->
0011000B816191083803F20000A78050E9935A1C5241D967553A2D328DA0A09308CA3EAB
529031D84C32B33A90915D074DD16FFA1C14769341CDF49C0E0ACBCBA0393DCD6683C2F6
709A1D16B3CBA0301D34A3CD6AA061B89D76BF41C4321B244DBF4153170B34ADA7E96590
0C8673818661361B648BE55AB81AAE15BBC162
2003-12-15 11:21:14 [5] DEBUG: AT2[16195192314]: --> ^Z
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:16 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:17 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:17 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:17 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:17 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:17 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:17 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:17 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:18 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:18 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:18 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:18 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:18 [7] DEBUG: boxc_receiver: sms received
2003-12-15 11:21:18 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:21:18 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 214
2003-12-15 11:21:18 [5] DEBUG: AT2[16195192314]: <-- OK
2003-12-15 11:21:18 [5] DEBUG: AT2[16195192314]: send command status: 0
------------------------------------------------------------------------
----

Here is the first message that failed:
------------------------------------------------------------------------
----2003-12-15 11:24:42 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2003-12-15 11:24:42 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:24:42 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:24:42 [5] DEBUG: AT2[16195192314]: send command status: 1
2003-12-15 11:24:42 [5] DEBUG: AT2[16195192314]: -->
0011000B818185378594F80000A78050E9935A1C5241D967553A2D328DA0A09308CA3EAB
529031D84C32B33A90915D074DD16FFA1C14769341CDF49C0E0ACBCBA0393DCD6683C2F6
709A1D16B3CBA0301D34A3CD6AA061B89D76BF41C4321B244DBF4153170B34ADA7E96590
0C8673818661361B648BE55AB81AAE15BBC162
2003-12-15 11:24:42 [5] DEBUG: AT2[16195192314]: --> ^Z
2003-12-15 11:24:43 [1] ERROR: Error reading from fd 28:
2003-12-15 11:24:43 [1] ERROR: System error 104: Connection reset by
peer
2003-12-15 11:24:43 [1] DEBUG: HTTP: Destroying HTTPClient area
0x80eaf50.
2003-12-15 11:24:43 [1] DEBUG: HTTP: Destroying HTTPClient for
`192.168.1.101'.
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: send command status: 1
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: -->
0011000B818185378594F80000A78050E9935A1C5241D967553A2D328DA0A09308CA3EAB
529031D84C32B33A90915D074DD16FFA1C14769341CDF49C0E0ACBCBA0393DCD6683C2F6
709A1D16B3CBA0301D34A3CD6AA061B89D76BF41C4321B244DBF4153170B34ADA7E96590
0C8673818661361B648BE55AB81AAE15BBC162
2003-12-15 11:24:45 [5] DEBUG: AT2[16195192314]: --> ^Z
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: send command status: 1
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: -->
0011000B818185378594F80000A78050E9935A1C5241D967553A2D328DA0A09308CA3EAB
529031D84C32B33A90915D074DD16FFA1C14769341CDF49C0E0ACBCBA0393DCD6683C2F6
709A1D16B3CBA0301D34A3CD6AA061B89D76BF41C4321B244DBF4153170B34ADA7E96590
0C8673818661361B648BE55AB81AAE15BBC162
2003-12-15 11:24:46 [5] DEBUG: AT2[16195192314]: --> ^Z
2003-12-15 11:24:47 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:24:47 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:24:47 [5] DEBUG: AT2[16195192314]: send command status: -1
------------------------------------------------------------------------
----    

Note that in this attempt to send, the modem returned an ERROR before
the message was sent in PDU format. 
------------------------------------------------------------------------
----
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: <-- 
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: <-- 
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: <-- 
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2003-12-15 11:25:23 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: <-- 
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: <-- 
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: <-- 
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:25:24 [5] DEBUG: AT2[16195192314]: send command status: -1
------------------------------------------------------------------------
----

Then later in the log, a message is successfully sent:
------------------------------------------------------------------------
----
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: TP-Validity-Period:
24.0 hours
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: <-- 
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: send command status: 1
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: -->
0011000B816191626146F60000A78050E9935A1C5241D967553A2D328DA0A09308CA3EAB
529031D84C32B33A90915D074DD16FFA1C14769341CDF49C0E0ACBCBA0393DCD6683C2F6
709A1D16B3CBA0301D34A3CD6AA061B89D76BF41C4321B244DBF4153170B34ADA7E96590
0C8673818661361B648BE55AB81AAE15BBC162
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: --> ^Z
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: <-- ERROR
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: send command status: -1
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: --> AT+CMGS=126^M
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: <-- >
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: send command status: 1
2003-12-15 11:26:00 [5] DEBUG: AT2[16195192314]: -->
0011000B816191626146F60000A78050E9935A1C5241D967553A2D328DA0A09308CA3EAB
529031D84C32B33A90915D074DD16FFA1C14769341CDF49C0E0ACBCBA0393DCD6683C2F6
709A1D16B3CBA0301D34A3CD6AA061B89D76BF41C4321B244DBF4153170B34ADA7E96590
0C8673818661361B648BE55AB81AAE15BBC162
2003-12-15 11:26:01 [5] DEBUG: AT2[16195192314]: --> ^Z
2003-12-15 11:26:01 [5] DEBUG: AT2[16195192314]: <-- +CMGS: 8
2003-12-15 11:26:01 [5] DEBUG: AT2[16195192314]: <-- OK
2003-12-15 11:26:01 [5] DEBUG: AT2[16195192314]: send command status: 0
------------------------------------------------------------------------
----

Any Help???

nicholas calugar
c/o battlemonkey.net
764 5th ave�ste a
san diego, ca 92101

619.865.1876
619.232.3292

[EMAIL PROTECTED]


-----Original Message-----
From: [EMAIL PROTECTED] [mailto:[EMAIL PROTECTED] On Behalf
Of Nicholas Calugar
Sent: Monday, December 15, 2003 9:39 AM
To: [EMAIL PROTECTED]
Subject: send command status: -1

System:
Debian Linux 2.4.23
Kannel 1.1.5 (Debian Package)
WaveCOM FastTrack GSM Modem on /dev/ttys0

I sent out a mass message using a PHP script that opens HTTP connections
to the gateway. The script finishes and I check the status of the
bearerbox. It shows the number sent and the number in queue approaching
each other as desired. Then I noticed that messages started failing
after sending 139.

This is the bearerbox log for the last message sent correctly
------------------------------------------------------------------------
----
2003-12-13 02:17:18 [6] DEBUG: send command status: 0
2003-12-13 02:17:18 [6] DEBUG: smscconn_sender (AT: /dev/ttyS0): sending
message
2003-12-13 02:17:18 [6] DEBUG: TP-Validity-Period: 24.0 hours
2003-12-13 02:17:18 [6] DEBUG: AT: Command: AT+CMGS=154

2003-12-13 02:17:18 [6] DEBUG: AT: Command:
0011000B816191520413F40000A7A0C2661154C48FD9F579DA5E0615ED65375D07A2BEDD
E9339A0E0AD341C370791E969FE6A061D85C06A170B01868089AD2532011B5DC86D3C3F4
F4DB3D0799DF72101D5D061DE5EFBB1B14769341D3323E2F0299E5EF3628076F83E86F90
2CDC7681642DF35BDE8A81C66F7B590EBAA7E968101D9D9E83DAE5F93C7C2EBB4050795A
5F061DD3F672F81ECECF43
------------------------------------------------------------------------
----

This is what the log shows next:
------------------------------------------------------------------------
----
2003-12-13 02:17:28 [6] DEBUG: send command status: -1
2003-12-13 02:17:28 [6] DEBUG: AT: Command:
0011000B816191520413F40000A7A0C2661154C48FD9F579DA5E0615ED65375D07A2BEDD
E9339A0E0AD341C370791E969FE6A061D85C06A170B01868089AD2532011B5DC86D3C3F4
F4DB3D0799DF72101D5D061DE5EFBB1B14769341D3323E2F0299E5EF3628076F83E86F90
2CDC7681642DF35BDE8A81C66F7B590EBAA7E968101D9D9E83DAE5F93C7C2EBB4050795A
5F061DD3F672F81ECECF43

2003-12-13 02:17:30 [6] DEBUG: send command status: -1
2003-12-13 02:17:30 [6] DEBUG: AT: Command:
0011000B816191520413F40000A7A0C2661154C48FD9F579DA5E0615ED65375D07A2BEDD
E9339A0E0AD341C370791E969FE6A061D85C06A170B01868089AD2532011B5DC86D3C3F4
F4DB3D0799DF72101D5D061DE5EFBB1B14769341D3323E2F0299E5EF3628076F83E86F90
2CDC7681642DF35BDE8A81C66F7B590EBAA7E968101D9D9E83DAE5F93C7C2EBB4050795A
5F061DD3F672F81ECECF43

2003-12-13 02:17:40 [6] DEBUG: send command status: -1
2003-12-13 02:17:40 [6] DEBUG: AT: Command:
0011000B816191520413F40000A7A0C2661154C48FD9F579DA5E0615ED65375D07A2BEDD
E9339A0E0AD341C370791E969FE6A061D85C06A170B01868089AD2532011B5DC86D3C3F4
F4DB3D0799DF72101D5D061DE5EFBB1B14769341D3323E2F0299E5EF3628076F83E86F90
2CDC7681642DF35BDE8A81C66F7B590EBAA7E968101D9D9E83DAE5F93C7C2EBB4050795A
5F061DD3F672F81ECECF43

2003-12-13 02:17:50 [6] DEBUG: send command status: -1
2003-12-13 02:17:50 [6] DEBUG: smsc_wrapper <AT: /dev/ttyS0>: reconnect
started
2003-12-13 02:17:50 [7] DEBUG: sms_router: time to sleep
2003-12-13 02:17:50 [6] INFO: Re-open of AT: /dev/ttyS0 succeeded.
2003-12-13 02:17:50 [7] DEBUG: sms_router: list_len = 432
2003-12-13 02:17:50 [6] DEBUG: smscconn_sender (AT: /dev/ttyS0): sending
message
2003-12-13 02:17:50 [6] DEBUG: TP-Validity-Period: 24.0 hours
2003-12-13 02:17:50 [6] DEBUG: AT: Command: AT+CMGS=154

2003-12-13 02:17:50 [6] DEBUG: AT: Command:
0011000B813101295319F50000A7A0C2661154C48FD9F579DA5E0615ED65375D07A2BEDD
E9339A0E0AD341C370791E969FE6A061D85C06A170B01868089AD2532011B5DC86D3C3F4
F4DB3D0799DF72101D5D061DE5EFBB1B14769341D3323E2F0299E5EF3628076F83E86F90
2CDC7681642DF35BDE8A81C66F7B590EBAA7E968101D9D9E83DAE5F93C7C2EBB4050795A
5F061DD3F672F81ECECF43
------------------------------------------------------------------------
----

Any suggestions or coments would be greatly appreciated.

thanks,

nicholas calugar
c/o battlemonkey.net
764 5th ave�ste a
san diego, ca 92101

619.865.1876
619.232.3292

[EMAIL PROTECTED]





Reply via email to