Hi, I am using Kannel and the Falcom Samba 55 modem as smsc and I have a problem while trying to send sms with kannel. My current version of kannel is cvs-20070424 but I had the same problem also with the latest stable version. Kannel and the Falcom modem seem to be initialized correct and generally I am able to send SMS. But, sometimes ,the sms cannot be send. Except from this, there is a command ^SYSSTART received by kannel from the modem . I have checked the user guide and the at command set of my modem and I can’t find anything relevant to ^SYSSTART. Also, sometimes this command comes when Kannel is idle and again, after this, any attempt to send a sms fails. The solution to all this, is to stop kannel plug and unplug the modem device and finally start again kannel. Below is the output of kannel in debug mode.
[EMAIL PROTECTED] ~]# /usr/local/sbin/bearerbox -v 0 /etc/mysmskannel.conf 2007-06-01 15:19:59 [2179] [0] INFO: Debug_lvl = 0, log_file = <none>, log_lvl = 0 2007-06-01 15:19:59 [2179] [0] INFO: DLR using storage type: internal 2007-06-01 15:19:59 [2179] [0] DEBUG: Kannel bearerbox version `cvs-20070424'. Build `May 14 2007 13:22:26', compiler `4.1.0 20060304 (Red Hat 4.1.0-3)'. System Linux, release 2.6.15-1.2054_FC5, version #1 Tue Mar 14 15:48:33 EST 2006, machine i686. Hostname localhost.localdomain, IP 127.0.0.1. Libxml version 2.6.23. Using OpenSSL 0.9.8a 11 Oct 2005. Using native malloc. 2007-06-01 15:19:59 [2179] [0] INFO: Started access logfile `/tmp/access.log'. 2007-06-01 15:19:59 [2179] [0] WARNING: 'store-file' option deprecated, please use 'store-location' and 'store-type' instead. 2007-06-01 15:19:59 [2179] [0] INFO: HTTP: Opening server at port 13000. 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller) 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 2 (gwlib/http.c:server_thread) 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 3 (gw/bb_http.c:httpadmin_run) 2007-06-01 15:19:59 [2179] [0] DEBUG: starting smsbox connection module 2007-06-01 15:19:59 [2179] [0] INFO: BOXC: 'smsbox-max-pending' not set, using default (100). 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 4 (gw/bb_boxc.c:sms_to_smsboxes) 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 5 (gw/bb_boxc.c:smsboxc_run) 2007-06-01 15:19:59 [2179] [0] INFO: Set SMS resend frequency to 60 seconds. 2007-06-01 15:19:59 [2179] [0] INFO: SMS resend retry set to unlimited. 2007-06-01 15:19:59 [2179] [0] INFO: DLR rerouting for smsc id <gsmmodem> disabled. 2007-06-01 15:19:59 [2179] [0] INFO: AT2[gsmmodem]: configuration shows modemtype <SIEMENS MC55> 2007-06-01 15:19:59 [2179] [0] DEBUG: AT2[gsmmodem]: Reading modem definitions from </etc/mysmskannel.conf> 2007-06-01 15:19:59 [2179] [0] DEBUG: AT2[gsmmodem]: Found <1> modems in config 2007-06-01 15:19:59 [2179] [0] INFO: AT2[gsmmodem]: read modem definition for <SIEMENS MC55> 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 6 (gw/smsc/smsc_at.c:at2_device_thread) 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 7 (gw/bb_smscconn.c:sms_router) 2007-06-01 15:19:59 [2179] [0] INFO: ---------------------------------------- 2007-06-01 15:19:59 [2179] [0] INFO: Kannel bearerbox II version cvs-20070424 starting 2007-06-01 15:19:59 [2179] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps to pid 2179. 2007-06-01 15:19:59 [2179] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) maps to pid 2179. 2007-06-01 15:19:59 [2179] [3] DEBUG: Thread 3 (gw/bb_http.c:httpadmin_run) maps to pid 2179. 2007-06-01 15:19:59 [2179] [4] DEBUG: Thread 4 (gw/bb_boxc.c:sms_to_smsboxes) maps to pid 2179. 2007-06-01 15:19:59 [2179] [5] DEBUG: Thread 5 (gw/bb_boxc.c:smsboxc_run) maps to pid 2179. 2007-06-01 15:19:59 [2179] [0] INFO: Loading store file `/tmp/kannel.store' 2007-06-01 15:19:59 [2179] [0] INFO: Store-file size 0, starting to unpack 2007-06-01 15:19:59 [2179] [0] INFO: Retrieved 0 messages, non-acknowledged messages: 0 2007-06-01 15:19:59 [2179] [0] DEBUG: Started thread 8 (gw/bb_store_file.c:store_dumper) 2007-06-01 15:19:59 [2179] [0] INFO: MAIN: Start-up done, entering mainloop 2007-06-01 15:19:59 [2179] [0] DEBUG: AT2[gsmmodem]: start called 2007-06-01 15:19:59 [2179] [6] DEBUG: Thread 6 (gw/smsc/smsc_at.c:at2_device_thread) maps to pid 2179. 2007-06-01 15:19:59 [2179] [6] INFO: AT2[gsmmodem]: trying to use speed <115200> from modem definition 2007-06-01 15:19:59 [2179] [6] INFO: AT2[gsmmodem]: opening device 2007-06-01 15:19:59 [2179] [7] DEBUG: Thread 7 (gw/bb_smscconn.c:sms_router) maps to pid 2179. 2007-06-01 15:19:59 [2179] [8] DEBUG: Thread 8 (gw/bb_store_file.c:store_dumper) maps to pid 2179. 2007-06-01 15:19:59 [2179] [8] DEBUG: Dumping 0 messages to store 2007-06-01 15:19:59 [2179] [6] DEBUG: AT2[gsmmodem]: device opened 2007-06-01 15:19:59 [2179] [6] DEBUG: AT2[gsmmodem]: device opened 2007-06-01 15:19:59 [2179] [6] INFO: AT2[gsmmodem]: speed set to 115200 2007-06-01 15:19:59 [2179] [6] DEBUG: AT2[gsmmodem]: --> ^M 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT^M 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:01 [2179] [6] INFO: AT2[gsmmodem]: closing device 2007-06-01 15:20:01 [2179] [6] INFO: AT2[gsmmodem]: speed is 115200 2007-06-01 15:20:01 [2179] [6] INFO: AT2[gsmmodem]: opening device 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: device opened 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: device opened 2007-06-01 15:20:01 [2179] [6] INFO: AT2[gsmmodem]: init device 2007-06-01 15:20:01 [2179] [6] INFO: AT2[gsmmodem]: speed set to 115200 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: --> ATZ^M 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT^M 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- AT 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT&F^M 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- AT&F 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: --> ATE0^M 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- ATE0 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT\Q3^M 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:01 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CPIN?^M 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- +CPIN: READY 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CMGF=0^M 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CSMS=?^M 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- +CSMS: (0,1) 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:02 [2179] [6] INFO: AT2[gsmmodem]: Phase 2+ is supported 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CSMS=1^M 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- +CSMS: 1,1,1 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CNMI=2,1,0,1,1^M 2007-06-01 15:20:02 [2179] [6] DEBUG: AT2[gsmmodem]: <-- OK 2007-06-01 15:20:02 [2179] [6] INFO: AT2[gsmmodem]: AT SMSC successfully opened.2007-06-01 15:20:18 [2179] [5] INFO: Client connected from <127.0.0.1> 2007-06-01 15:20:18 [2179] [5] DEBUG: Started thread 9 (gw/bb_boxc.c:function) 2007-06-01 15:20:18 [2179] [9] DEBUG: Thread 9 (gw/bb_boxc.c:function) maps to pid 2179. 2007-06-01 15:20:18 [2179] [9] DEBUG: Started thread 10 (gw/bb_boxc.c:boxc_sender) 2007-06-01 15:20:18 [2179] [10] DEBUG: Thread 10 (gw/bb_boxc.c:boxc_sender) maps to pid 2179. 2007-06-01 15:22:15 [2179] [9] DEBUG: boxc_receiver: sms received 2007-06-01 15:22:15 [2179] [9] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2007-06-01 15:22:16 [2179] [6] DEBUG: AT2[gsmmodem]: TP-Validity-Period: 5 minutes 2007-06-01 15:22:16 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CMGS=34^M 2007-06-01 15:22:16 [2179] [6] DEBUG: AT2[gsmmodem]: <-- > 2007-06-01 15:22:16 [2179] [6] DEBUG: AT2[gsmmodem]: send command status: 1 2007-06-01 15:22:16 [2179] [6] DEBUG: AT2[gsmmodem]: --> 0011000A8196374713570011001868F5590D5A9FD16AD01A7D06A9D76850918AA11631 2007-06-01 15:22:16 [2179] [6] DEBUG: AT2[gsmmodem]: --> ^Z 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- > 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- ERROR 2007-06-01 15:22:17 [2179] [6] ERROR: AT2[gsmmodem]: Generic error: ERROR 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: send command status: -1 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CMGS=34^M 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- > 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: send command status: 1 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: --> 0011000A8196374713570011001868F5590D5A9FD16AD01A7D06A9D76850918AA11631 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: --> ^Z 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- > 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- ERROR 2007-06-01 15:22:17 [2179] [6] ERROR: AT2[gsmmodem]: Generic error: ERROR 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: send command status: -1 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: --> AT+CMGS=34^M 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- > 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: send command status: 1 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: --> 0011000A8196374713570011001868F5590D5A9FD16AD01A7D06A9D76850918AA11631 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: --> ^Z 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- > 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: <-- ERROR 2007-06-01 15:22:17 [2179] [6] ERROR: AT2[gsmmodem]: Generic error: ERROR 2007-06-01 15:22:17 [2179] [6] DEBUG: AT2[gsmmodem]: send command status: -1 2007-06-01 15:22:26 [2179] [6] DEBUG: AT2[gsmmodem]: <-- ^SYSSTART 2007-06-01 15:22:29 [2179] [8] DEBUG: Dumping 0 messages to store Has anyone faced this problem before? Any suggestions would be greatly appreciated. Thanks in Advance, Vasilis Manolopoulos Research & Development Department CARDISOFT SA C Monastiriou 60, 546 27 Thessaloniki +30 2310 567840 +30 2310 514220 www.cardisoft.gr r [EMAIL PROTECTED]
