Re: Wavecom Modem Buffering but not sending

[Nikos Balkanas]

Hi,

Please repost detailed logs, clearly labeling each one and seperate them. 
Cannot understand what is going on here. Do not use us...@vm1.kannel.org.

BR,
Nikos
----- Original Message ----- 
From: "Peter" <p...@locosms.gr>
To: "Nikos Balkanas" <nbalka...@gmail.com>
Cc: <us...@vm1.kannel.org>
Sent: Friday, May 21, 2010 5:45 PM
Subject: Re: Wavecom Modem Buffering but not sending


Dear friends,
I cannot get the modem to send an SMS. The access.log which is very
concise and depicts the situation is the following. Message remains in
the modem as I then use a minicom terminal emulator and the
AT+CMGL=4 command to see the message as a string of hex values. It
message remains in store and never leaves the modem.

2010-05-21 15:56:29 Log begins
2010-05-21 15:57:35 send-SMS request added - sender:tester:123456789
127.0.0.1 target:306937123456 request: 'Ξ“IA THN ONOMAΞ£TIKH Ξ£AΞ£ EOPTH 
Ξ£AΞ£
EYXOMAΣTE XPONIA ΠOΛΛA'
2010-05-21 15:57:38 Sent SMS [SMSC:wavecom_1] [SVC:tester] [ACT:]
[BINF:] [FID:15] [from:123456789] [to:306937123456]
[flags:-1:0:-1:-1:31] [msg:55:.IA THN ONOMA.TIKH .A. EOPTH .A. EYXOMA.TE
XPONIA .O..A] [udh:0:]
2010-05-21 15:57:38 Receive DLR [SMSC:wavecom_1] [SVC:tester] [ACT:]
[BINF:] [FID:15] [from:123456789] [to:306937123456]
[flags:-1:-1:-1:-1:8] [msg:4:ACK/] [udh:0:]
2010-05-21 15:57:39 Receive DLR [SMSC:wavecom_1] [SVC:tester] [ACT:]
[BINF:] [FID:15] [from:123456789] [to:306937123456]
[flags:-1:-1:-1:-1:4] [msg:8:Buffered] [udh:0:]


Στις 18-05-2010, ημέ�α Τ�ι, και ��α 22:03 +0300, ο/η 
Nikos Balkanas
έγ�α�ε:
Hi,

Please separate clearly smsbox logs from bearerbox logs. Having them 
mixed
like that makes very difficult to follow.

It seems that SMS reaches your provider and is then buffered by them. 
This
is not a kannel issue. Final DLR and SMS delivery is asynchronous and
depends on destination availability. Sometimes it may take as long as 2 
days
before SMS is returned as expired.

I don't see anything wrong from your side, here.

BR,
Nikos
----- Original Message ----- 
From: Peter
To: us...@vm1.kannel.org
Sent: Tuesday, May 18, 2010 8:47 PM
Subject: Wavecom Modem Buffering but not sending


Dear all,
I am installing a wavecom modem on kannel 1.4.3 and although kannel seems 
to
communicate with the modem, when we send an MT SMS we see that the 
message
is buffered but not sent.
The SIM card is operational in a normal mobile phone, by sending and
receiving messages.
Your help will be greatly appreciated.


Dr. Peter Kontopoulos

++++++++++++++++++++++++++++++++++
kannel.conf

# CORE SETUP
group = core
admin-port = 13000
admin-password = 123
status-password = 123
admin-deny-ip = "*.*.*.*"
admin-allow-ip = "127.0.0.1"
log-file = "/var/log/kannel/kannel.log"
log-level = 2
access-log = "/var/log/kannel/access.log"
smsbox-port = 13001
wapbox-port = 13002
store-location = "/var/log/kannel/kannel.store"
store-type = file
box-deny-ip = "*.*.*.*"
box-allow-ip = "127.0.0.1"
dlr-storage = mysql

# SMSBOX SETUP
group = smsbox
bearerbox-host = localhost
bearerbox-port = 13001
sendsms-port = 13013
sendsms-chars = "0123456789+"
log-file = "/var/log/kannel/smsbox.log"
log-level = 1
access-log = "/var/log/kannel/access.log"

include = "/etc/kannel/kannel.mdm"

include = "/etc/kannel/kannel.dlr"

# SMS SERVICE 'Default'
# there should be default always
group = sms-service
keyword = default
max-messages = 0
exec = /usr/local/bin/kannel_incoming %t %q %Q %a
#get-url =
"http://localhost/plugin/gateway/kannel/geturl.php?t=%t&q=%q&a=%a";
accept-x-kannel-headers = "true"
text = "thank you"

++++++++++++++++++++++++++++++++++++++++++
kannel/kannel.mdm

# Modems configuration
#
# Example and default values
#
# group = modems
# id = "my-id"
# name = "my-name"
# detect-string = "MODEM"
# detect-string2 = "" [Default]
# init-string = "AT+CNMI=1,2,0,0,0" [Default]
# speed = 9600 [Default]
# enable-hwhs = "AT+IFC=2,2" [Default]
# need-sleep = false [Default]
# no-pin = false [Default]
# no-smsc = false [Default]
# sendline-sleep = 100 [Default, miliseconds]
# keepalive-cmd = "AT" [Default]
# broken = false [Default]
# message-storage = "SM"
# enable-mms = false [Default]

group = smsc
smsc = at
smsc-id = wavecom_1
allowed-smsc-id = wavecom_1
modemtype = wavecom
device = /dev/ttyS0
speed = 9600
pin = 4980
sim-buffering = true
max-error-count = 5

group = modems
id = wavecom
name = Wavecom
detect-string = "WAVECOM"
init-string = "AT+CNMI=2,0,0,1,0"
reset-string = "AT+CFUN=1"

# SEND-SMS USERS
group = sendsms-user
username = tester
password = foobar
max-messages = 3
concatenation = 1
#user-deny-ip = ""
#user-allow-ip = ""
forced-smsc = wavecom_1

++++++++++++++++++++++++++++++++++++++
access.log

2010-05-18 19:09:22 send-SMS request added - sender:tester:123456789
127.0.0.1 target:306937123456 request: '!...@#$%^&*()-_=+{}[]<>,.?/\|"':;~'
€£¤¥§¿
1234567890
1234567890
1234567890
1234'
2010-05-18 19:09:28 Sent SMS [SMSC:wavecom_1] [SVC:tester] [ACT:] [BINF:]
[FID:4] [from:123456789] [to:306937123456] [flags:-1:0:-1:-1:31]
[msg:160:!.#.%..&*()-.=+.(.).<.><>,.?/./.@"':;.='..e.$._`.AB..EZH.IK.MN.O.P.TY.X....AB..EZH.IK.MN.O.P.TY.X...AEHIOY..AEHIOY..IYIYIY.1234567890.1234567890.1234567890.1234]
[udh:0:]
2010-05-18 19:09:28 Receive DLR [SMSC:wavecom_1] [SVC:tester] [ACT:] 
[BINF:]
[FID:4] [from:123456789] [to:306937123456] [flags:-1:-1:-1:-1:8]
[msg:4:ACK/] [udh:0:]
2010-05-18 19:09:28 Receive DLR [SMSC:wavecom_1] [SVC:tester] [ACT:] 
[BINF:]
[FID:4] [from:123456789] [to:306937123456] [flags:-1:-1:-1:-1:4]
[msg:8:Buffered] [udh:0:]
2010-05-18 19:47:29 Log ends

+++++++++++++++++++++++++++++++++++++
console output (-v 0)

2010-05-18 20:31:34 [7008] [0] INFO: Connected to bearerbox at localhost
port 13001.
2010-05-18 20:31:34 [7008] [0] DEBUG: Started thread 7
(gw/heartbeat.c:heartbeat_thread)
2010-05-18 20:31:34 [7008] [7] DEBUG: Thread 7
(gw/heartbeat.c:heartbeat_thread) maps to pid 7008.
2010-05-18 20:32:05 [6952] [2] DEBUG: HTTP: Creating HTTPClient for
`127.0.0.1'.
2010-05-18 20:32:05 [6952] [2] DEBUG: HTTP: Created HTTPClient area
0x8ada838.
2010-05-18 20:32:05 [6952] [3] DEBUG: sql: SELECT count(*) FROM dlr;
2010-05-18 20:32:05 [6952] [3] DEBUG: HTTP: Destroying HTTPClient area
0x8ada838.
2010-05-18 20:32:05 [6952] [3] DEBUG: HTTP: Destroying HTTPClient for
`127.0.0.1'.
2010-05-18 20:32:14 [6952] [6] DEBUG: AT2[wavecom_1]: --> AT+CPMS?^M
2010-05-18 20:32:14 [6952] [6] DEBUG: AT2[wavecom_1]: <-- +CPMS:
"SM",0,40,"SM",0,40
2010-05-18 20:32:14 [6952] [6] DEBUG: AT2[wavecom_1]: <-- OK
2010-05-18 20:32:24 [7008] [2] DEBUG: HTTP: Creating HTTPClient for
`127.0.0.1'.
2010-05-18 20:32:24 [7008] [2] DEBUG: HTTP: Created HTTPClient area
0xb4200550.
2010-05-18 20:32:24 [7008] [3] INFO: smsbox: Got HTTP request
</cgi-bin/sendsms> from <127.0.0.1>
2010-05-18 20:32:24 [7008] [3] INFO: sendsms used by <tester>
2010-05-18 20:32:24 [7008] [3] INFO: sendsms sender:<tester:123456789>
(127.0.0.1) to:<306937123456> msg:<!...@#$%^&*()-_=+{}[]<>,.?/\|"':;~'
€£¤¥§¿
1234567890
1234567890
1234567890
1234>
2010-05-18 20:32:24 [7008] [3] INFO: send-sms request smsc id ignored, as
smsc id forced to wavecom_1
2010-05-18 20:32:24 [7008] [3] DEBUG: Stored UUID
d0b0afa5-9eaf-45d6-a75f-684bb10febfa
2010-05-18 20:32:24 [7008] [3] DEBUG: message length 181, sending 1 
messages
2010-05-18 20:32:24 [7008] [3] DEBUG: Status: 202 Answer: <Sent.>
2010-05-18 20:32:24 [7008] [3] DEBUG: Delayed reply - wait for bearerbox
2010-05-18 20:32:24 [6952] [16] DEBUG: boxc_receiver: sms received
2010-05-18 20:32:24 [6952] [16] DEBUG: send_msg: sending msg to box:
<127.0.0.1>
2010-05-18 20:32:24 [7008] [0] DEBUG: Got ACK (0) of
d0b0afa5-9eaf-45d6-a75f-684bb10febfa
2010-05-18 20:32:24 [7008] [0] DEBUG: HTTP: Destroying HTTPClient area
0xb4200550.
2010-05-18 20:32:24 [7008] [0] DEBUG: HTTP: Destroying HTTPClient for
`127.0.0.1'.
2010-05-18 20:32:26 [6952] [6] DEBUG: AT2[wavecom_1]: TP-Validity-Period:
24.0 hours
2010-05-18 20:32:26 [6952] [6] DEBUG: AT2[wavecom_1]: --> AT+CMGS=154^M
2010-05-18 20:32:26 [6952] [6] DEBUG: AT2[wavecom_1]: <-- >
2010-05-18 20:32:26 [6952] [6] DEBUG: AT2[wavecom_1]: send command 
status: 1
2010-05-18 20:32:26 [6952] [6] DEBUG: AT2[wavecom_1]: -->
0031000C810396731231160000A7A021C04850DA504C2A54AA15E9AD36A84D6AC3DBF8783E96EBF7DABC3640D149B7DBF44E8A4D39401A7CC18AA07002296A9199E492D2746A9E1628869A95602F158C22289C408A5A6426B9A4349D9AA7058AA16625D84B45112C2293CF6C45112C2293CF6C4591CC26B3C9AC22269BD16AB61B2E0753C464335ACD76C3E5608A986C46ABD96EB81C4C1193CD68
2010-05-18 20:32:26 [6952] [6] DEBUG: AT2[wavecom_1]: --> ^Z
2010-05-18 20:32:29 [6952] [6] DEBUG: AT2[wavecom_1]: <-- >
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: <-- +CMGS: 5
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: <-- OK
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: send command 
status: 0
2010-05-18 20:32:30 [6952] [6] DEBUG: DLR[mysql]: Adding DLR 
smsc=wavecom_1,
ts=5, src=123456789, dst=306937123456, mask=31, boxc=
2010-05-18 20:32:30 [6952] [6] DEBUG: sql: INSERT INTO dlr (smsc, ts,
source, destination, service, url, mask, boxc, status) VALUES 
('wavecom_1',
'5', '123456789', '306937123456', 'tester',
'http://localhost/plugin/gateway/kannel/dlr.php?type=%d&slid=1699046&uid=1',
'31', '', '0');
2010-05-18 20:32:30 [6952] [6] DEBUG: SMSC[wavecom_1]: creating DLR 
message
2010-05-18 20:32:30 [6952] [6] DEBUG: SMSC[wavecom_1]: DLR =
http://localhost/plugin/gateway/kannel/dlr.php?type=%d&slid=1699046&uid=1
2010-05-18 20:32:30 [6952] [17] DEBUG: send_msg: sending msg to box:
<127.0.0.1>
2010-05-18 20:32:30 [6952] [17] DEBUG: boxc_sender: sent message to
<127.0.0.1>
2010-05-18 20:32:30 [7008] [4] INFO: Starting delivery report <tester> 
from
<123456789>
2010-05-18 20:32:30 [7008] [4] DEBUG: Started thread 8
(gwlib/fdset.c:poller)
2010-05-18 20:32:30 [7008] [8] DEBUG: Thread 8 (gwlib/fdset.c:poller) 
maps
to pid 7008.
2010-05-18 20:32:30 [7008] [4] DEBUG: Started thread 9
(gwlib/http.c:write_request_thread)
2010-05-18 20:32:30 [7008] [9] DEBUG: Thread 9
(gwlib/http.c:write_request_thread) maps to pid 7008.
2010-05-18 20:32:30 [7008] [9] DEBUG: Queue contains 0 pending requests.
2010-05-18 20:32:30 [7008] [9] DEBUG: Parsing URL
`http://localhost/plugin/gateway/kannel/dlr.php?type=8&slid=1699046&uid=1':
2010-05-18 20:32:30 [7008] [9] DEBUG:   Scheme: http://
2010-05-18 20:32:30 [7008] [9] DEBUG:   Host: localhost
2010-05-18 20:32:30 [7008] [9] DEBUG:   Port: 80
2010-05-18 20:32:30 [7008] [9] DEBUG:   Username: (null)
2010-05-18 20:32:30 [7008] [9] DEBUG:   Password: (null)
2010-05-18 20:32:30 [7008] [9] DEBUG:   Path: 
/plugin/gateway/kannel/dlr.php
2010-05-18 20:32:30 [7008] [9] DEBUG:   Query: type=8&slid=1699046&uid=1
2010-05-18 20:32:30 [7008] [9] DEBUG:   Fragment: (null)
2010-05-18 20:32:30 [6952] [16] DEBUG: boxc_receiver: got ack
2010-05-18 20:32:30 [7008] [9] DEBUG: HTTP: Opening connection to
`localhost:80' (fd=28).
2010-05-18 20:32:30 [7008] [9] DEBUG: Socket connecting
2010-05-18 20:32:30 [7008] [8] DEBUG: Get info about connecting socket
2010-05-18 20:32:30 [7008] [8] DEBUG: HTTP: Sending request:
2010-05-18 20:32:30 [7008] [8] DEBUG: Octet string at 0x97ba120:
2010-05-18 20:32:30 [7008] [8] DEBUG:   len:  140
2010-05-18 20:32:30 [7008] [8] DEBUG:   size: 1024
2010-05-18 20:32:30 [7008] [8] DEBUG:   immutable: 0
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 47 45 54 20 2f 70 6c 75 67 
69
6e 2f 67 61 74 65   GET /plugin/gate
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 77 61 79 2f 6b 61 6e 6e 65 
6c
2f 64 6c 72 2e 70   way/kannel/dlr.p
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 68 70 3f 74 79 70 65 3d 38 
26
73 6c 69 64 3d 31   hp?type=8&slid=1
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 36 39 39 30 34 36 26 75 69 
64
3d 31 20 48 54 54   699046&uid=1 HTT
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 50 2f 31 2e 31 0d 0a 48 6f 
73
74 3a 20 6c 6f 63   P/1.1..Host: loc
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 61 6c 68 6f 73 74 0d 0a 43 
6f
6e 6e 65 63 74 69   alhost..Connecti
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 6f 6e 3a 20 6b 65 65 70 2d 
61
6c 69 76 65 0d 0a   on: keep-alive..
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 55 73 65 72 2d 41 67 65 6e 
74
3a 20 4b 61 6e 6e   User-Agent: Kann
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 65 6c 2f 31 2e 34 2e 33 0d 
0a
0d 0a               el/1.4.3....
2010-05-18 20:32:30 [7008] [8] DEBUG: Octet string dump ends.
2010-05-18 20:32:30 [7008] [8] DEBUG: HTTP: Status line: <HTTP/1.1 200 
OK>
2010-05-18 20:32:30 [7008] [8] DEBUG: HTTP: Received response:
2010-05-18 20:32:30 [7008] [8] DEBUG: Octet string at 0x97b6048:
2010-05-18 20:32:30 [7008] [8] DEBUG:   len:  301
2010-05-18 20:32:30 [7008] [8] DEBUG:   size: 1024
2010-05-18 20:32:30 [7008] [8] DEBUG:   immutable: 0
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 44 61 74 65 3a 20 54 75 65 
2c
20 31 38 20 4d 61   Date: Tue, 18 Ma
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 79 20 32 30 31 30 20 31 37 
3a
33 32 3a 33 30 20   y 2010 17:32:30
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 47 4d 54 0d 0a 53 65 72 76 
65
72 3a 20 41 70 61   GMT..Server: Apa
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 63 68 65 2f 32 2e 32 2e 31 
32
20 28 55 62 75 6e   che/2.2.12 (Ubun
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 74 75 29 0d 0a 58 2d 50 6f 
77
65 72 65 64 2d 42   tu)..X-Powered-B
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 79 3a 20 50 48 50 2f 35 2e 
32
2e 31 30 2d 32 75   y: PHP/5.2.10-2u
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 62 75 6e 74 75 36 2e 34 0d 
0a
50 72 61 67 6d 61   buntu6.4..Pragma
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 3a 20 6e 6f 2d 63 61 63 68 
65
0d 0a 53 65 74 2d   : no-cache..Set-
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 43 6f 6f 6b 69 65 3a 20 6c 
61
6e 67 3d 65 6c 3b   Cookie: lang=el;
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 20 70 61 74 68 3d 2f 70 6c 
75
67 69 6e 2f 67 61    path=/plugin/ga
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 74 65 77 61 79 2f 6b 61 6e 
6e
65 6c 2f 0d 0a 56   teway/kannel/..V
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 61 72 79 3a 20 41 63 63 65 
70
74 2d 45 6e 63 6f   ary: Accept-Enco
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 64 69 6e 67 0d 0a 43 6f 6e 
74
65 6e 74 2d 4c 65   ding..Content-Le
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 6e 67 74 68 3a 20 30 0d 0a 
4b
65 65 70 2d 41 6c   ngth: 0..Keep-Al
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 69 76 65 3a 20 74 69 6d 65 
6f
75 74 3d 31 35 2c   ive: timeout=15,
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 20 6d 61 78 3d 31 30 30 0d 
0a
43 6f 6e 6e 65 63    max=100..Connec
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 74 69 6f 6e 3a 20 4b 65 65 
70
2d 41 6c 69 76 65   tion: Keep-Alive
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 0d 0a 43 6f 6e 74 65 6e 74 
2d
54 79 70 65 3a 20   ..Content-Type:
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 74 65 78 74 2f 68 74 6d 6c 
0d
0a 0d 0a            text/html....
2010-05-18 20:32:30 [7008] [8] DEBUG: Octet string dump ends.
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: <-- +CDS: 25
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: <--
0006050C81039673123116015081022323210150810223232130
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: received message 
from
SMSC:
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: got STATUS-REPORT 
for
message <5>:
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: Numeric receiver
<306937123456>
2010-05-18 20:32:30 [6952] [6] DEBUG: DLR[mysql]: Looking for DLR
smsc=wavecom_1, ts=5, dst=306937123456, type=4
2010-05-18 20:32:30 [6952] [6] DEBUG: sql: SELECT mask, service, url,
source, destination, boxc FROM dlr WHERE smsc='wavecom_1' AND ts='5';
2010-05-18 20:32:30 [6952] [6] DEBUG: Found entry, row[0]=31, 
row[1]=tester,
row[2]=http://localhost/plugin/gateway/kannel/dlr.php?type=%d&slid=1699046&uid=1,
row[3]=123456789, row[4]=306937123456 row[5]=
2010-05-18 20:32:30 [6952] [6] DEBUG: DLR[mysql]: created DLR message for
URL
<http://localhost/plugin/gateway/kannel/dlr.php?type=%d&slid=1699046&uid=1>
2010-05-18 20:32:30 [6952] [6] DEBUG: DLR[mysql]: DLR not destroyed, 
still
waiting for other delivery report
2010-05-18 20:32:30 [6952] [6] DEBUG: updating DLR status in database
2010-05-18 20:32:30 [6952] [6] DEBUG: sql: UPDATE dlr SET status=4 WHERE
smsc='wavecom_1' AND ts='5' LIMIT 1;
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: --> AT+CNMA^M
2010-05-18 20:32:30 [6952] [17] DEBUG: send_msg: sending msg to box:
<127.0.0.1>
2010-05-18 20:32:30 [6952] [17] DEBUG: boxc_sender: sent message to
<127.0.0.1>
2010-05-18 20:32:30 [7008] [4] INFO: Starting delivery report <tester> 
from
<123456789>
2010-05-18 20:32:30 [7008] [9] DEBUG: Queue contains 0 pending requests.
2010-05-18 20:32:30 [7008] [9] DEBUG: Parsing URL
`http://localhost/plugin/gateway/kannel/dlr.php?type=4&slid=1699046&uid=1':
2010-05-18 20:32:30 [7008] [9] DEBUG:   Scheme: http://
2010-05-18 20:32:30 [7008] [9] DEBUG:   Host: localhost
2010-05-18 20:32:30 [7008] [9] DEBUG:   Port: 80
2010-05-18 20:32:30 [7008] [9] DEBUG:   Username: (null)
2010-05-18 20:32:30 [7008] [9] DEBUG:   Password: (null)
2010-05-18 20:32:30 [7008] [9] DEBUG:   Path: 
/plugin/gateway/kannel/dlr.php
2010-05-18 20:32:30 [7008] [9] DEBUG:   Query: type=4&slid=1699046&uid=1
2010-05-18 20:32:30 [7008] [9] DEBUG:   Fragment: (null)
2010-05-18 20:32:30 [6952] [16] DEBUG: boxc_receiver: got ack
2010-05-18 20:32:30 [7008] [9] DEBUG: HTTP: Reusing connection to
`localhost:80' (fd=28).
2010-05-18 20:32:30 [7008] [9] DEBUG: Socket connected at once
2010-05-18 20:32:30 [7008] [9] DEBUG: HTTP: Sending request:
2010-05-18 20:32:30 [7008] [9] DEBUG: Octet string at 0x97b34e8:
2010-05-18 20:32:30 [7008] [9] DEBUG:   len:  140
2010-05-18 20:32:30 [7008] [9] DEBUG:   size: 1024
2010-05-18 20:32:30 [7008] [9] DEBUG:   immutable: 0
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 47 45 54 20 2f 70 6c 75 67 
69
6e 2f 67 61 74 65   GET /plugin/gate
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 77 61 79 2f 6b 61 6e 6e 65 
6c
2f 64 6c 72 2e 70   way/kannel/dlr.p
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 68 70 3f 74 79 70 65 3d 34 
26
73 6c 69 64 3d 31   hp?type=4&slid=1
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 36 39 39 30 34 36 26 75 69 
64
3d 31 20 48 54 54   699046&uid=1 HTT
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 50 2f 31 2e 31 0d 0a 48 6f 
73
74 3a 20 6c 6f 63   P/1.1..Host: loc
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 61 6c 68 6f 73 74 0d 0a 43 
6f
6e 6e 65 63 74 69   alhost..Connecti
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 6f 6e 3a 20 6b 65 65 70 2d 
61
6c 69 76 65 0d 0a   on: keep-alive..
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 55 73 65 72 2d 41 67 65 6e 
74
3a 20 4b 61 6e 6e   User-Agent: Kann
2010-05-18 20:32:30 [7008] [9] DEBUG:   data: 65 6c 2f 31 2e 34 2e 33 0d 
0a
0d 0a               el/1.4.3....
2010-05-18 20:32:30 [7008] [9] DEBUG: Octet string dump ends.
2010-05-18 20:32:30 [7008] [8] DEBUG: HTTP: Status line: <HTTP/1.1 200 
OK>
2010-05-18 20:32:30 [7008] [8] DEBUG: HTTP: Received response:
2010-05-18 20:32:30 [7008] [8] DEBUG: Octet string at 0x97b36d8:
2010-05-18 20:32:30 [7008] [8] DEBUG:   len:  300
2010-05-18 20:32:30 [7008] [8] DEBUG:   size: 1024
2010-05-18 20:32:30 [7008] [8] DEBUG:   immutable: 0
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 44 61 74 65 3a 20 54 75 65 
2c
20 31 38 20 4d 61   Date: Tue, 18 Ma
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 79 20 32 30 31 30 20 31 37 
3a
33 32 3a 33 30 20   y 2010 17:32:30
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 47 4d 54 0d 0a 53 65 72 76 
65
72 3a 20 41 70 61   GMT..Server: Apa
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 63 68 65 2f 32 2e 32 2e 31 
32
20 28 55 62 75 6e   che/2.2.12 (Ubun
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 74 75 29 0d 0a 58 2d 50 6f 
77
65 72 65 64 2d 42   tu)..X-Powered-B
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 79 3a 20 50 48 50 2f 35 2e 
32
2e 31 30 2d 32 75   y: PHP/5.2.10-2u
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 62 75 6e 74 75 36 2e 34 0d 
0a
50 72 61 67 6d 61   buntu6.4..Pragma
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 3a 20 6e 6f 2d 63 61 63 68 
65
0d 0a 53 65 74 2d   : no-cache..Set-
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 43 6f 6f 6b 69 65 3a 20 6c 
61
6e 67 3d 65 6c 3b   Cookie: lang=el;
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 20 70 61 74 68 3d 2f 70 6c 
75
67 69 6e 2f 67 61    path=/plugin/ga
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 74 65 77 61 79 2f 6b 61 6e 
6e
65 6c 2f 0d 0a 56   teway/kannel/..V
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 61 72 79 3a 20 41 63 63 65 
70
74 2d 45 6e 63 6f   ary: Accept-Enco
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 64 69 6e 67 0d 0a 43 6f 6e 
74
65 6e 74 2d 4c 65   ding..Content-Le
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 6e 67 74 68 3a 20 30 0d 0a 
4b
65 65 70 2d 41 6c   ngth: 0..Keep-Al
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 69 76 65 3a 20 74 69 6d 65 
6f
75 74 3d 31 35 2c   ive: timeout=15,
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 20 6d 61 78 3d 39 39 0d 0a 
43
6f 6e 6e 65 63 74    max=99..Connect
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 69 6f 6e 3a 20 4b 65 65 70 
2d
41 6c 69 76 65 0d   ion: Keep-Alive.
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 0a 43 6f 6e 74 65 6e 74 2d 
54
79 70 65 3a 20 74   .Content-Type: t
2010-05-18 20:32:30 [7008] [8] DEBUG:   data: 65 78 74 2f 68 74 6d 6c 0d 
0a
0d 0a               ext/html....
2010-05-18 20:32:30 [7008] [8] DEBUG: Octet string dump ends.
2010-05-18 20:32:30 [6952] [6] DEBUG: AT2[wavecom_1]: <-- OK
2010-05-18 20:32:34 [6952] [16] DEBUG: boxc_receiver: heartbeat with load
value 0 received
2010-05-18 20:32:35 [6952] [11] DEBUG: Dumping 20 messages to store
2010-05-18 20:32:45 [7008] [8] DEBUG: HTTP: Server closed connection,
destroying it <localhost:80:0::><0x97c02f8><fd:28>.
2010-05-18 20:33:05 [6952] [2] DEBUG: HTTP: Creating HTTPClient for
`127.0.0.1'.
2010-05-18 20:33:05 [6952] [2] DEBUG: HTTP: Created HTTPClient area
0x8ada820.
2010-05-18 20:33:05 [6952] [3] DEBUG: sql: SELECT count(*) FROM dlr;
2010-05-18 20:33:05 [6952] [3] DEBUG: HTTP: Destroying HTTPClient area
0x8ada820.
2010-05-18 20:33:05 [6952] [3] DEBUG: HTTP: Destroying HTTPClient for
`127.0.0.1'.
2010-05-18 20:33:16 [6952] [6] DEBUG: AT2[wavecom_1]: --> AT+CPMS?^M
2010-05-18 20:33:16 [6952] [6] DEBUG: AT2[wavecom_1]: <-- +CPMS:
"SM",0,40,"SM",0,40
2010-05-18 20:33:16 [6952] [6] DEBUG: AT2[wavecom_1]: <-- OK
2010-05-18 20:34:05 [6952] [2] DEBUG: HTTP: Creating HTTPClient for
`127.0.0.1'.
2010-05-18 20:34:05 [6952] [2] DEBUG: HTTP: Created HTTPClient area
0x8ada820.
2010-05-18 20:34:05 [6952] [3] DEBUG: sql: SELECT count(*) FROM dlr;
2010-05-18 20:34:05 [6952] [3] DEBUG: HTTP: Destroying HTTPClient area
0x8ada820.
2010-05-18 20:34:05 [6952] [3] DEBUG: HTTP: Destroying HTTPClient for
`127.0.0.1'.
2010-05-18 20:34:18 [6952] [6] DEBUG: AT2[wavecom_1]: --> AT+CPMS?^M
2010-05-18 20:34:18 [6952] [6] DEBUG: AT2[wavecom_1]: <-- +CPMS:
"SM",0,40,"SM",0,40
2010-05-18 20:34:18 [6952] [6] DEBUG: AT2[wavecom_1]: <-- OK






Dr. Peter Kontopoulos
CTO locotel sa

p...@locotel.gr
Parnassou 2, Athens 10561, Greece
Tel. +30 210 3258350
Fax. +30 210 3258359

www.locotel.gr



Dr. Peter Kontopoulos
CTO locotel sa

p...@locotel.gr
Parnassou 2, Athens 10561, Greece
Tel. +30 210 3258350
Fax. +30 210 3258359

www.locotel.gr