Re: Trouble setting up GSM Modem

Thu, 17 Sep 2009 00:38:58 -0700 


Hi Nikos,
Thank you for the response. This morning I went and made the change to the modem type field to use the id and not the name. After making that change I decided to try and fix the WARNING: No translation found for in the sms box. What I found after a while was that SMS-SERVICE config is incorrect. It looks like I can not set the keyword to being blank. 

#Kannel.conf

group = sms-service
keyword-regex = .*
catch-all = yes
accepted-smsc = TESTLONG
get-url = "http://test.local/engine.php?sender=%p&destination=%P&text=%b&smsc=%i&msgid=%I&operator=%o"; 
max-messages = 0
assume-plain-text = true
omit-empty = true

# End of kannel.conf
Now when Kannel is running I do not seem to get the PDU. I was wondering if some could clarify if this means that the problem is solved or that because the message is now processed correctly that the event that causes the error does not occur. 

Kind Regards,

Wilhelm Ellmann



Nikos Balkanas wrote:

Hi,
Sorry for replying in portions. It seems that you have a configuration issue that prevents correct modem initialization:
In group smsc, modemType should match id in group modems, not name. Name is text used only in logging. 

BR,
Nikos
----- Original Message ----- From: "Nikos Balkanas" <[email protected]>
To: "Nikos Balkanas" <[email protected]>; "Wilhelm Ellmann | Fontera" <[email protected]>; <[email protected]> 
Sent: Thursday, September 17, 2009 1:35 AM
Subject: Re: Trouble setting up GSM Modem
Also try adding AT+CMEE = 1 or 2 in your init-string to get more detailed info from your modem. 

BR,
Nikos
----- Original Message ----- From: "Nikos Balkanas" <[email protected]> To: "Wilhelm Ellmann | Fontera" <[email protected]>; <[email protected]> 
Sent: Wednesday, September 16, 2009 11:45 PM
Subject: Re: Trouble setting up GSM Modem



Hi,
There seems to be a problem right after you send the PDU (TPDU 27 octets): 

0011000B917228283085F70000A70ED272BC5E9ED341C6709A5D2603

Does anyone know how to read it?

BR,
Nikos
----- Original Message ----- From: "Wilhelm Ellmann | Fontera" <[email protected]> 
To: <[email protected]>
Sent: Wednesday, September 16, 2009 5:56 PM
Subject: Trouble setting up GSM Modem



Hi,
I seem be having a trouble setting up my GSM modem to work correctly. My 
goal is not to send messages through the modem I only want receive
messages and push them on to my script to be processed.

There are two problems that I am having. The first is that once I have
received a message it looks like to me that the server tries to
acknowledge that it has received the message but runs into a error. This 
causes a problem as the message is stored in the store file and the
server continually tries to re-acknowledge.

2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[EDGARSLONG]: send command
status: 1
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[EDGARSLONG]: -->
0011000B917228283085F70000A70ED272BC5E9ED341C6709A5D2603
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[EDGARSLONG]: --> ^Z
2009-09-16 15:19:02 [22753] [6] DEBUG: AT2[EDGARSLONG]: <-- >
2009-09-16 15:19:02 [22753] [6] DEBUG: AT2[EDGARSLONG]: <-- ERROR
2009-09-16 15:19:02 [22753] [6] ERROR: AT2[EDGARSLONG]: Generic error: ERROR 
2009-09-16 15:19:02 [22753] [6] DEBUG: AT2[EDGARSLONG]: send command
status: -1
2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: handling message
(0x8f35200 vs 0x8f35200)
2009-09-16 15:19:02 [22753] [7] DEBUG: re-queing SMS not-yet-to-be resent 
2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: handling message
(0x8f35200 vs 0x8f35200)
2009-09-16 15:19:02 [22753] [7] DEBUG: re-queing SMS not-yet-to-be resent 2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: time to sleep 30.00 secs. 
2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: gwlist_len = 1

From what I can find on the internet is that it is a problem with my
init-string in modems config file. Is this correct and how can I find
the correct values that is supposed to be entered in here.
My second problem that I am having on receiving the message the sms box is telling me this ( the snippet below ) and not forwarding the message 
on. I am stumped as I am using a similar config on my other services

2009-09-16 15:18:55 [22758] [4] DEBUG: match found: ^[ ]*()[ ]*
2009-09-16 15:18:55 [22758] [4] WARNING: No translation found for <This 
is a good test> from <+2782*****87> to <2773*****30>
2009-09-16 15:18:55 [22758] [4] ERROR: request failed
2009-09-16 15:18:55 [22758] [4] DEBUG: message length 14, sending 1 messages 
2009-09-16 15:18:55 [22758] [0] DEBUG: Got ACK (0) of
455e08bb-6081-4820-b600-5fcbe6a8aa90
2009-09-16 15:18:55 [22758] [0] DEBUG: No client - multi-send or ACK to 
pull-reply

I have attached my config file and logs and would appreciate any help.

--

Kind Regards,

Wilhelm Ellmann
-------------------------------------------------------------------------------- 



.
2009-09-16 15:18:47 [22758] [0] INFO: Added logfile `/var/log/kannel/smsbox.log' with level `0'. 2009-09-16 15:18:47 [22758] [0] INFO: Logging accesses to '/var/log/kannel/smsbox.access'. 2009-09-16 15:18:47 [22758] [0] INFO: Started access logfile `/var/log/kannel/smsbox.access'. 2009-09-16 15:18:47 [22758] [0] INFO: HTTP: Opening server at port 13013. 2009-09-16 15:18:47 [22758] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller) 2009-09-16 15:18:47 [22758] [0] DEBUG: Started thread 2 (gwlib/http.c:server_thread) 2009-09-16 15:18:47 [22758] [0] INFO: Set up send sms service at port 13013 2009-09-16 15:18:47 [22758] [0] DEBUG: Started thread 3 (gw/smsbox.c:sendsms_thread) 2009-09-16 15:18:47 [22758] [0] DEBUG: ---------------------------------------------- 2009-09-16 15:18:47 [22758] [0] DEBUG: Kannel smsbox version 1.4.2 starting 2009-09-16 15:18:47 [22758] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps to pid 22758. 2009-09-16 15:18:47 [22758] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) maps to pid 22758. 2009-09-16 15:18:47 [22758] [3] DEBUG: Thread 3 (gw/smsbox.c:sendsms_thread) maps to pid 22758. 2009-09-16 15:18:47 [22758] [0] DEBUG: Started thread 4 (gw/smsbox.c:obey_request_thread) 2009-09-16 15:18:47 [22758] [0] DEBUG: Started thread 5 (gw/smsbox.c:url_result_thread) 2009-09-16 15:18:47 [22758] [0] DEBUG: Started thread 6 (gw/smsbox.c:http_queue_thread) 2009-09-16 15:18:47 [22758] [0] INFO: Connected to bearerbox at 127.0.0.1 port 13001. 2009-09-16 15:18:47 [22758] [0] DEBUG: Started thread 7 (gw/heartbeat.c:heartbeat_thread) 2009-09-16 15:18:47 [22758] [4] DEBUG: Thread 4 (gw/smsbox.c:obey_request_thread) maps to pid 22758. 2009-09-16 15:18:47 [22758] [5] DEBUG: Thread 5 (gw/smsbox.c:url_result_thread) maps to pid 22758. 2009-09-16 15:18:47 [22758] [6] DEBUG: Thread 6 (gw/smsbox.c:http_queue_thread) maps to pid 22758. 2009-09-16 15:18:47 [22758] [7] DEBUG: Thread 7 (gw/heartbeat.c:heartbeat_thread) maps to pid 22758. 
2009-09-16 15:18:55 [22758] [4] DEBUG: match found: ^[ ]*()[ ]*
2009-09-16 15:18:55 [22758] [4] WARNING: No translation found for <This is a good test> from <+2782*****87> to <2773*****30> 
2009-09-16 15:18:55 [22758] [4] ERROR: request failed
2009-09-16 15:18:55 [22758] [4] DEBUG: message length 14, sending 1 messages 2009-09-16 15:18:55 [22758] [0] DEBUG: Got ACK (0) of 455e08bb-6081-4820-b600-5fcbe6a8aa90 2009-09-16 15:18:55 [22758] [0] DEBUG: No client - multi-send or ACK to pull-reply
-------------------------------------------------------------------------------- 



.
2009-09-16 15:18:47 Log begins
2009-09-16 15:18:55 Receive SMS [SMSC:EDGARSLONG] [SVC:] [ACT:] [BINF:] [FID:] [from:+27828203587] [to:27730920930] [flags:-1:0:-1:0:-1] [msg:19:This is a good test] [udh:0:] 
2009-09-16 15:19:28 Log ends
-------------------------------------------------------------------------------- 



.
2009-09-16 15:18:47 [22753] [0] INFO: Added logfile `/var/log/kannel/bearerbox.log' with level `0'. 2009-09-16 15:18:47 [22753] [0] INFO: Started access logfile `/var/log/kannel/bearerbox.access'. 2009-09-16 15:18:47 [22753] [0] INFO: HTTP: Opening server at port 13000. 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller) 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 2 (gwlib/http.c:server_thread) 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 3 (gw/bb_http.c:httpadmin_run) 2009-09-16 15:18:47 [22753] [0] DEBUG: starting smsbox connection module 2009-09-16 15:18:47 [22753] [0] INFO: BOXC: 'smsbox-max-pending' not set, using default (100). 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 4 (gw/bb_boxc.c:sms_to_smsboxes) 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 5 (gw/bb_boxc.c:smsboxc_run) 2009-09-16 15:18:47 [22753] [0] INFO: Set SMS resend frequency to 60 seconds. 2009-09-16 15:18:47 [22753] [0] INFO: SMS resend retry set to unlimited. 2009-09-16 15:18:47 [22753] [0] DEBUG: smsbox MO concatenated message handling enabled 2009-09-16 15:18:47 [22753] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps to pid 22753. 2009-09-16 15:18:47 [22753] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) maps to pid 22753. 2009-09-16 15:18:47 [22753] [3] DEBUG: Thread 3 (gw/bb_http.c:httpadmin_run) maps to pid 22753. 2009-09-16 15:18:47 [22753] [4] DEBUG: Thread 4 (gw/bb_boxc.c:sms_to_smsboxes) maps to pid 22753. 2009-09-16 15:18:47 [22753] [5] DEBUG: Thread 5 (gw/bb_boxc.c:smsboxc_run) maps to pid 22753. 2009-09-16 15:18:47 [22753] [0] INFO: DLR rerouting for smsc id <TESTLONG> disabled. 2009-09-16 15:18:47 [22753] [0] INFO: AT2[TESTLONG]: configuration shows modemtype <TestModem> 2009-09-16 15:18:47 [22753] [0] DEBUG: AT2[TESTLONG]: Reading modem definitions from </etc/kannel.conf> 2009-09-16 15:18:47 [22753] [0] DEBUG: AT2[TESTLONG]: Found <1> modems in config 2009-09-16 15:18:47 [22753] [0] INFO: AT2[TESTLONG]: modemtype not found, revert to autodetect 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 6 (gw/smsc/smsc_at.c:at2_device_thread) 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 7 (gw/bb_smscconn.c:sms_router) 2009-09-16 15:18:47 [22753] [0] DEBUG: starting UDP sender/receiver module 
2009-09-16 15:18:47 [22753] [0] INFO: Adding interface *
2009-09-16 15:18:47 [22753] [0] DEBUG: udpc_create: Bound to UDP <0.0.0.0:9200> 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 8 (gw/bb_udp.c:udp_receiver) 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 9 (gw/bb_udp.c:udp_sender) 2009-09-16 15:18:47 [22753] [0] DEBUG: udpc_create: Bound to UDP <0.0.0.0:9201> 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 10 (gw/bb_udp.c:udp_receiver) 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 11 (gw/bb_udp.c:udp_sender) 2009-09-16 15:18:47 [22753] [0] DEBUG: starting wapbox connection module 2009-09-16 15:18:47 [22753] [0] ERROR: Missing wapbox-port variable, cannot start WAP 
2009-09-16 15:18:47 [22753] [0] DEBUG: starting WDP router
2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 12 (gw/bearerbox.c:wdp_router) 2009-09-16 15:18:47 [22753] [0] INFO: ---------------------------------------- 2009-09-16 15:18:47 [22753] [0] INFO: Kannel bearerbox II version 1.4.2 starting 2009-09-16 15:18:47 [22753] [0] INFO: Loading store file `/var/log/kannel/kannel.store' 2009-09-16 15:18:47 [22753] [0] INFO: Store-file size 0, starting to unpack 2009-09-16 15:18:47 [22753] [0] INFO: Retrieved 0 messages, non-acknowledged messages: 0 2009-09-16 15:18:47 [22753] [0] DEBUG: Started thread 13 (gw/bb_store_file.c:store_dumper) 2009-09-16 15:18:47 [22753] [0] INFO: MAIN: Start-up done, entering mainloop 
2009-09-16 15:18:47 [22753] [0] DEBUG: AT2[TESTLONG]: start called
2009-09-16 15:18:47 [22753] [6] DEBUG: Thread 6 (gw/smsc/smsc_at.c:at2_device_thread) maps to pid 22753. 2009-09-16 15:18:47 [22753] [6] DEBUG: AT2[TESTLONG]: detecting modem type 
2009-09-16 15:18:47 [22753] [6] INFO: AT2[TESTLONG]: opening device
2009-09-16 15:18:47 [22753] [13] DEBUG: Thread 13 (gw/bb_store_file.c:store_dumper) maps to pid 22753. 
2009-09-16 15:18:47 [22753] [13] DEBUG: Dumping 0 messages to store
2009-09-16 15:18:47 [22753] [7] DEBUG: Thread 7 (gw/bb_smscconn.c:sms_router) maps to pid 22753. 2009-09-16 15:18:47 [22753] [8] DEBUG: Thread 8 (gw/bb_udp.c:udp_receiver) maps to pid 22753. 2009-09-16 15:18:47 [22753] [9] DEBUG: Thread 9 (gw/bb_udp.c:udp_sender) maps to pid 22753. 2009-09-16 15:18:47 [22753] [10] DEBUG: Thread 10 (gw/bb_udp.c:udp_receiver) maps to pid 22753. 2009-09-16 15:18:47 [22753] [11] DEBUG: Thread 11 (gw/bb_udp.c:udp_sender) maps to pid 22753. 2009-09-16 15:18:47 [22753] [12] DEBUG: Thread 12 (gw/bearerbox.c:wdp_router) maps to pid 22753. 2009-09-16 15:18:47 [22753] [12] DEBUG: udp_die: removing producers from udp-lists 2009-09-16 15:18:47 [22753] [12] DEBUG: Thread 12 (gw/bearerbox.c:wdp_router) terminates. 2009-09-16 15:18:47 [22753] [5] INFO: Client connected from <127.0.0.1> 2009-09-16 15:18:47 [22753] [5] DEBUG: Started thread 14 (gw/bb_boxc.c:function) 2009-09-16 15:18:47 [22753] [14] DEBUG: Thread 14 (gw/bb_boxc.c:function) maps to pid 22753. 2009-09-16 15:18:47 [22753] [14] DEBUG: Started thread 15 (gw/bb_boxc.c:boxc_sender) 2009-09-16 15:18:47 [22753] [15] DEBUG: Thread 15 (gw/bb_boxc.c:boxc_sender) maps to pid 22753. 2009-09-16 15:18:47 [22753] [6] DEBUG: AT2[TESTLONG]: device opened. Telnet mode = 0 
2009-09-16 15:18:48 [22753] [6] DEBUG: AT2[TESTLONG]: device opened
2009-09-16 15:18:48 [22753] [6] INFO: AT2[TESTLONG]: speed set to 57600 
2009-09-16 15:18:48 [22753] [6] DEBUG: AT2[TESTLONG]: --> ^M
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT^M
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- AT
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT&F^M
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- AT&F
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: --> ATE0^M
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- ATE0
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: --> ATI^M
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- MO200 GPRS
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: found string <MO200>, using modem definition <TestModem> 
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CSMS=?^M
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- +CSMS: (0)
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:50 [22753] [6] INFO: AT2[TESTLONG]: Closing device
2009-09-16 15:18:50 [22753] [6] INFO: AT2[TESTLONG]: opening device
2009-09-16 15:18:50 [22753] [6] DEBUG: AT2[TESTLONG]: device opened. Telnet mode = 0 
2009-09-16 15:18:51 [22753] [6] DEBUG: AT2[TESTLONG]: device opened
2009-09-16 15:18:51 [22753] [6] INFO: AT2[TESTLONG]: Logging in
2009-09-16 15:18:52 [22753] [6] INFO: AT2[TESTLONG]: init device
2009-09-16 15:18:52 [22753] [6] INFO: AT2[TESTLONG]: speed set to 57600 
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> ATZ^M
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT^M
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- AT
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT&F^M
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- AT&F
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> ATE0^M
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- ATE0
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CMGF=0^M
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CSMS=?^M
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- +CSMS: (0)
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CNMI=2,0,0,1,0^M 
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:52 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CPMS="SM"^M 2009-09-16 15:18:53 [22753] [6] DEBUG: AT2[TESTLONG]: <-- +CPMS: 1,25,0,100,1,125 
2009-09-16 15:18:53 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:53 [22753] [6] INFO: AT2[TESTLONG]: AT SMSC successfully opened. 
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CPMS?^M
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: <-- +CPMS: "SM",1,25,"ME",0,100,"MT",1,125 
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: 1 messages waiting in memory 
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CMGR=1^M
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: <-- +CMGR: 0,,36
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: <-- 06917228195329240B917228283085F70000909061512103801354747A0E4ACF4161D0F9FD2683E8E5391D 2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: received message from SMSC: +2782913592 2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: Numeric sender (international) <+2782*****87> 2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: User data length read as (19) 2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: Udh decoding done len=19 udhi=0 udhlen=0 udh='' 2009-09-16 15:18:55 [22753] [15] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2009-09-16 15:18:55 [22753] [15] DEBUG: boxc_sender: sent message to <127.0.0.1> 
2009-09-16 15:18:55 [22753] [14] DEBUG: boxc_receiver: sms received
2009-09-16 15:18:55 [22753] [14] DEBUG: send_msg: sending msg to box: <127.0.0.1> 
2009-09-16 15:18:55 [22753] [14] DEBUG: boxc_receiver: got ack
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:55 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CMGD=1^M
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[TESTLONG]: <-- OK
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[TESTLONG]: TP-Validity-Period: 24.0 hours 
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[TESTLONG]: --> AT+CMGS=27^M
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[TESTLONG]: <-- >
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[TESTLONG]: send command status: 1 2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[TESTLONG]: --> 0011000B917228283085F70000A70ED272BC5E9ED341C6709A5D2603 
2009-09-16 15:18:56 [22753] [6] DEBUG: AT2[TESTLONG]: --> ^Z
2009-09-16 15:19:02 [22753] [6] DEBUG: AT2[TESTLONG]: <-- >
2009-09-16 15:19:02 [22753] [6] DEBUG: AT2[TESTLONG]: <-- ERROR
2009-09-16 15:19:02 [22753] [6] ERROR: AT2[TESTLONG]: Generic error: ERROR 2009-09-16 15:19:02 [22753] [6] DEBUG: AT2[TESTLONG]: send command status: -1 2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: handling message (0x8f35200 vs 0x8f35200) 2009-09-16 15:19:02 [22753] [7] DEBUG: re-queing SMS not-yet-to-be resent 2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: handling message (0x8f35200 vs 0x8f35200) 2009-09-16 15:19:02 [22753] [7] DEBUG: re-queing SMS not-yet-to-be resent 2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: time to sleep 30.00 secs. 
2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: gwlist_len = 1
2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: handling message (0x8f35200 vs 0x8f35200) 2009-09-16 15:19:02 [22753] [7] DEBUG: re-queing SMS not-yet-to-be resent 2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: handling message (0x8f35200 vs 0x8f35200) 2009-09-16 15:19:02 [22753] [7] DEBUG: re-queing SMS not-yet-to-be resent 2009-09-16 15:19:02 [22753] [7] DEBUG: sms_router: time to sleep 30.00 secs. 
2009-09-16 15:19:07 [22753] [13] DEBUG: Dumping 1 messages to store
2009-09-16 15:19:17 [22753] [14] DEBUG: boxc_receiver: heartbeat with load value 0 received 2009-09-16 15:19:26 [22753] [14] INFO: Connection closed by the box <127.0.0.1> 2009-09-16 15:19:26 [22753] [15] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2009-09-16 15:19:26 [22753] [15] DEBUG: Thread 15 (gw/bb_boxc.c:boxc_sender) terminates. 2009-09-16 15:19:26 [22753] [14] DEBUG: Thread 14 (gw/bb_boxc.c:function) terminates. 2009-09-16 15:19:26 [22753] [0] WARNING: Killing signal or HTTP admin command received, shutting down... 
2009-09-16 15:19:26 [22753] [0] DEBUG: Shutting down Kannel...
2009-09-16 15:19:26 [22753] [0] DEBUG: shutting down smsc
2009-09-16 15:19:26 [22753] [0] DEBUG: AT2[TESTLONG]: Shutting down SMSCConn, slow 
2009-09-16 15:19:26 [22753] [0] DEBUG: shutting down udp
2009-09-16 15:19:26 [22753] [7] DEBUG: sms_router: gwlist_len = 1
2009-09-16 15:19:26 [22753] [7] DEBUG: sms_router: handling message (0x8f35200 vs 0x8f35200) 
2009-09-16 15:19:26 [22753] [7] DEBUG: Routing failed, re-queued.
2009-09-16 15:19:26 [22753] [7] DEBUG: Thread 7 (gw/bb_smscconn.c:sms_router) terminates. 2009-09-16 15:19:26 [22753] [8] DEBUG: Thread 8 (gw/bb_udp.c:udp_receiver) terminates. 2009-09-16 15:19:26 [22753] [9] DEBUG: Thread 9 (gw/bb_udp.c:udp_sender) terminates. 2009-09-16 15:19:26 [22753] [10] DEBUG: Thread 10 (gw/bb_udp.c:udp_receiver) terminates. 2009-09-16 15:19:26 [22753] [11] DEBUG: Thread 11 (gw/bb_udp.c:udp_sender) terminates. 
2009-09-16 15:19:28 [22753] [6] INFO: AT2[TESTLONG]: Closing device
2009-09-16 15:19:28 [22753] [6] DEBUG: Thread 6 (gw/smsc/smsc_at.c:at2_device_thread) terminates. 2009-09-16 15:19:28 [22753] [4] DEBUG: Thread 4 (gw/bb_boxc.c:sms_to_smsboxes) terminates. 2009-09-16 15:19:28 [22753] [5] DEBUG: Thread 5 (gw/bb_boxc.c:smsboxc_run) terminates. 2009-09-16 15:19:28 [22753] [0] INFO: All flow threads have died, killing core 2009-09-16 15:19:28 [22753] [0] DEBUG: Waiting for 2 (gwlib/http.c:server_thread) to terminate 2009-09-16 15:19:28 [22753] [3] DEBUG: HTTP: No clients with requests, quitting. 2009-09-16 15:19:28 [22753] [3] DEBUG: Thread 3 (gw/bb_http.c:httpadmin_run) terminates. 2009-09-16 15:19:28 [22753] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) terminates. 2009-09-16 15:19:28 [22753] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) terminates. 
2009-09-16 15:19:28 [22753] [0] DEBUG: final clean-up for SMSCConn
2009-09-16 15:19:28 [22753] [0] DEBUG: smsbox MO concatenated message handling cleaned up 
2009-09-16 15:19:28 [22753] [13] DEBUG: Dumping 1 messages to store
2009-09-16 15:19:28 [22753] [13] DEBUG: Thread 13 (gw/bb_store_file.c:store_dumper) terminates. 2009-09-16 15:19:28 [22753] [0] INFO: Total WDP messages: received 0, sent 0 2009-09-16 15:19:28 [22753] [0] INFO: Total SMS messages: received 1, sent 0 
2009-09-16 15:19:28 [22753] [0] DEBUG: Immutable octet strings: 245.
-------------------------------------------------------------------------------- 



# Bearerbox configuration file
group = core
admin-port = 13000
admin-password = test
status-password = test
admin-deny-ip = "*.*.*.*"
admin-allow-ip = "127.0.0.1;192.168.0.*"
smsbox-port = 13001
#wapbox-port = 13002
box-deny-ip = "*.*.*.*"
box-allow-ip = "127.0.0.1"
udp-deny-ip = "*.*.*.*"
udp-deny-ip = "127.0.0.1"
wdp-interface-name = "*"
log-file = "/var/log/kannel/bearerbox.log"
log-level = 0
access-log = "/var/log/kannel/bearerbox.access"
store-type = file
store-location = "/var/log/kannel/kannel.store"
dlr-storage = internal

## Wapbox Setup
#group = wapbox
#bearerbox-host = "127.0.0.1"
#log-file = "/var/log/kannel/wapbox.log"
#log-level = 1
#access-log = "/var/log/kannel/wapbox.access"

# SmsBox Setup
group = smsbox
bearerbox-host = 127.0.0.1
sendsms-port = 13013
log-file = "/var/log/kannel/smsbox.log"
log-level = 0
access-log = "/var/log/kannel/smsbox.access"

# Edgars long number 073 *** **30
group = smsc
smsc = at
modemtype = TestModem
device = /dev/ttyUSB0
speed = 57600
my-number = 2773*****30
sim-buffering = true
smsc-id = TESTLONG
allowed-smsc-id = TESTLONG

group = modems
id = modem1
name = TestModem
detect-string = MO200
#detect-string2 = GPRS
init-string = "AT+CNMI=2,0,0,1,0"
enable-hwhs = ""
speed = 57600
need-sleep = true
no-pin = true
sendline-sleep = 100
keepalive-cmd = "AT+CBC;+CSQ"
message-storage = "SM"
#enable-mms = false

group = sms-service
keyword =
#accepted-smsc = TESTLONG
get-url = "http://test.local/engine.php?sender=%p&destination=%P&text=%b&smsc=%i&msgid=%I&operator=%o"; 
max-messages = 0
assume-plain-text = true
omit-empty = true
-------------------------------------------------------------------------------- 



.
-------------------------------------------------------------------------------- 



.
2009-09-16 15:18:47 Log begins

Reply via email to