Hola Alejandro: Thanks for your kind offer. A pair of fresh eyes is always good. You (or someone else) may spot things that I am overlooking!
I am sending through sqlbox over SMPP and this is the dlr-url I am using: http://*.*.*.*/cgi-bin/dlr.php?to%3D%25to%26msisdn%3D%25msisdn%26status%3D% 25status%26messagId%3D1008928%26scts%3D%25scts [My provider uses the parameters to¹, msisdn¹, status¹ and scts¹ for the Call Back]. I checked the Apache log and everything is 200 OK. A week ago I started trying using only bearerbox and sqlbox but I have returned to using the smsbox, too. I keep getting the message ³WARNING: Could not route message to smsbox id <0>, smsbox is gone!² (see ³LOG smpp-provider² below). I can see the values from the ³deliver_sm² in that same log: ³id:0038791787 su b:001 dlvrd:001 submit date:1107122104 done date:1107121853 stat:DELIVRD err:000 text:none² But why do I fail to store it? The dlr.php is a very simple one: >>> dlr.php <<< <?php include('../../mysql_connect2.php'); $messageId=$_GET['messageId']; $status=$_GET['status']; $query ="UPDATE verslag SET status='$status' WHERE id_sms='$messageId'"; $result = mysql_query($query) or die("Query failed : " . mysql_error()); ?> Please have a look at the information. Any suggestions most welcome! Regards, Michael PD La neciedad puede ser una virtud. Ya tengo semanas trabajando en esto! On 12/7/11 06:38, "Alejandro Mejia Evertsz" <[email protected]> wrote: > Hola Michael, > > Are you sending through smsbox or mysqlbox? > I'm using smsbox, and the URL I'm calling to send the message looks like > this: > > http://x.x.x.x:8080/cgi-bin/sendsms?username=mysuername&password=mypassword&to > =mymobile&text=Hello+world&dlr-mask=31&dlr-url=http://y.y.y.y/dlr.cgi?id=mysms > ID%26status=%d > Please note the last & (ampersand) is url-encoded, so the script from > which I'm calling this URL doesn't think this is another parameter, and > not part of "dlr-url". (let me know if I'm not being clear hehehe) > > This way the dlr will call: > http://y.y.y.y/dlr.cgi?id=mysmsID&status=%d > > Are you using Apache to run your dlr.cgi script on y.y.y.y ? > If so, you could check your apache logs to see wether you're getting the > request from kannel or not. > > Another thing I use to debug is running bearerbox and smsbox directly > from the shell so I'm able to see what kannel is doing, because first of > all, you should check if the smsc is posting the dlr to kannel or not. > (maybe I should have started by saying this hehehe) > > Let me know if I can be of any help. > > Buena suerte! > > Alejandro > > On 11/07/2011 10:49 p.m., Michael van der Poel wrote: >> Hi Alejandro, >> >> Sorry, I hadn't seen Nikos's reply. >> I can see the "deliver_sm" with all the information (the "full dlr") in the >> logs but so far I can't manage to capture it into my MySQL table. Tan cerca >> pero tan lejos! Soon I will crack it, though. >> >> Best of luck with your endeavours! >> >> >> Michael >> >> On 12/7/11 04:26, "Alejandro Mejia Evertsz"<[email protected]> wrote: >> >>> Hi Michael, >>> >>> I had this already figured out by reading the UG and experimenting a >>> little. (maybe more than a little hehehe) >>> I'm getting the first dlr from the smsc and it's calling my dlr-url >>> correctly (I made a perl .cgi that get's the parameters and store the >>> new dlr status on mysql). >>> So far, I guess we both got to the same place ;) >>> >>> My doubt was about the dlr-mask I was using (because I thought I wasn't >>> requesting smsc the right thing for it to give me full dlrs). >>> Nikos confirmed that I'm using the right mask, so now I have to strugle >>> with my operator's smsc. >>> I guess I'll try the other 2 operators smsc with other sims on the same >>> phone to check if any of them provide with full dlrs. >>> >>> Thanks a lot for the time you took to explain me how dlr-url works. >>> >>> Cheers! >>> >>> Alejandro >>> >>> On 11/07/2011 05:01 p.m., Michael van der Poel wrote: >>>> Hi Alejandro, >>>> >>>> I wish, I could give you the full answer to your question, but I am >>>> struggling now for some weeks to recover the full DLR and store it in a >>>> MySQL database. I have learned some things in those weeks and I hope, I >>>> will >>>> finally accomplish it soon. >>>> >>>> What I have figured out so far, is: >>>> >>>> - you receive a first DLR (the "submit_sm_resp ") that serves as an >>>> acknowledgement from your provider (e.g., 8). This just means, that the >>>> provider has received your request to send the SMS; >>>> - it is the second DLR (the "deliver_sm" that you are looking for where the >>>> provider confirms whether the message was actually delivered (or whether >>>> the >>>> attempts to deliver the message failed, the mobile number was incorrect, >>>> ect.). >>>> >>>> This second message is delivered over HTTP and you will have to set up a >>>> Call Back URL (something like: >>>> >>>">http://yourserver.com/dlr.php?smscID=%i&dlr=%d&answer=%A&to=%p&from=%P&ts=% >>>> <http://yourserver.com/dlr.php?smscID=%i&dlr=%d&answer=%A&to=%p&from=%P&ts=%> T >>>> &smsID=07fceb25372fcc4cb847c7099008500e&charset=%C&kannel_id=%I) >>>> >>>> This is called the dlr-url which you will have to define in your kannel >>>> configuration, and on your server you will need a php script, that your >>>> provider can call and submit the values of the delivery report to. These >>>> will come in the form of parameters such as '%p' and '%u' (see pggs. 94-95 >>>> of the UG). >>>> The php script captures these values and stores them in your database. This >>>> is the bit where I am stuck :-( >>>> >>>> There is plenty of material in the UG and in the various forums. What >>>> beginning Kannel users like you and I miss, is a good description of how it >>>> all comes together. I am sure that once we have see everything working, we >>>> will say "Ah, of course!". >>>> >>>> Anyhow, I hope, the above will help to get you started and maybe the >>>> experts >>>> can correct me where I am wrong. >>>> >>>> >>>> Regards, >>>> >>>> >>>> >>>> >>>> Michael >>>> >>>> >>>> >>>> On 11/7/11 23:17, "Alejandro Mejia Evertsz"<[email protected]> wrote: >>>> >>>>> Hello everyone. >>>>> Excuse me for this dumb question, but I got lost on the UG regarding this. >>>>> I'm using an LG phone and I have MT and MO working fine. >>>>> When sending a message via HTTP I'm setting dlr-mask=31 >>>>> >>>>> I'm getting DLR correctly but only with status = 8 (delivered to smsc). >>>>> When I get the sms on my mobile phone, there's nothing being received by >>>>> kannel, so my guessing is that I'm setting dlr-mask with a value that >>>>> doesn't ask my mobile operator to get a DLR for the sent message. Or am >>>>> I wrong? >>>>> Can someone explain which are valid values for dlr-mask if I want to >>>>> request for full DLR to the operator? >>>>> (I'm sure my operator supports DLR, because when sending from the phone >>>>> with this option enabled, I get a DLR when it gets delivered on the >>>>> destination's mobile) >>>>> >>>>> Thanks in advance for your time. >>>>> >>>>> Regards, >>>>> >>>>> Alejandro >>>>> >> >
>>> kannel.conf <<< # # Sample configuration file for Kannel bearerbox # See the documentation for explanations of fields. # group = core admin-port = 13000 admin-password = bar admin-deny-ip = "*.*.*.*" admin-allow-ip = "127.0.0.1" smsbox-port = 13003 log-file = "/var/log/kannel/bearerbox.log" box-deny-ip = "*.*.*.*" box-allow-ip = "127.0.0.1" dlr-storage=mysql log-level=0 group = smsbox bearerbox-host="localhost" sendsms-port = 13013 sendsms-chars = "+0123456789" log-file = "/var/log/kannel/smsbox.log" log-level = 0 access-log = "/var/log/kannel/access.log" log-level = 0 mo-recode = 1 group = smsbox-route smsbox-id = sqlbox smsc-id = smpp-provider group = smsc smsc = smpp smsc-id = smpp-provider host = msg1.provider.com port = 8000 receive-port = 8000 #transceiver-mode = false transceiver-mode = 1 throughput = 10 smsc-username = username smsc-password = password system-type = username dest-addr-ton=1 log-file = "/var/log/kannel/smpp-provider.log" log-level = 0 msg-id-type=0x01 enquire-link-interval = 30 dlr-url="http://*.*.*.*/cgi-bin/dlr.php?to=%to&msisdn=%msisdn&status=%status&messagId=%messagId&scts=%scts"; group = sendsms-user username = username password = pwd forced-smsc = smpp-provider name = users user-deny-ip = "*.*.*.*" user-allow-ip = "127.0.0.1" max-messages = 3 concatenation = 1 omit-empty = 1 group = sms-service keyword = default text = "No action specified" catch-all = true accepted-smsc = smpp # DLR SETUP #mysql connection group = mysql-connection id = mydlr host = localhost username = gebruikersnaam password = geheimwoord database = tekstberichten max-connections = 5 group = dlr-db id = mydlr table=verslag field-smsc=smsc field-timestamp=ts field-destination=dst field-source=source field-service=service field-url=url field-mask=mask field-status=status field-boxc-id=boxc_id >>> sqlbox.conf <<< group = sqlbox id = sqlbox-db smsbox-id = sqlbox global-sender = "my number" bearerbox-host = localhost bearerbox-port = 13003 smsbox-port = 13005 smsbox-port-ssl = false sql-log-table = sent_sms sql-insert-table = send_sms log-file = "/var/log/kannel/kannel-sqlbox.log" log-level = 0 # MySQL Connection group=mysql-connection id =sqlbox-db host = localhost username = gebruikersnaam password = geheimwoord database = tekstberichten max-connections = 1 >>> Log bearerbox <<< 2011-07-12 19:04:35 [7611] [11] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2011-07-12 19:04:35 [7611] [9] DEBUG: send_msg: sending msg to boxc: <sqlbox> 2011-07-12 19:04:35 [7611] [11] DEBUG: Thread 11 (gw/bb_boxc.c:boxc_sender) terminates. 2011-07-12 19:04:35 [7611] [9] DEBUG: Thread 9 (gw/bb_boxc.c:boxc_sender) terminates. 2011-07-12 19:04:35 [7611] [10] DEBUG: boxc_receiver: heartbeat with load value 0 received 2011-07-12 19:04:35 [7611] [10] INFO: Connection closed by the box <127.0.0.1> 2011-07-12 19:04:35 [7611] [10] DEBUG: Thread 10 (gw/bb_boxc.c:function) terminates. 2011-07-12 19:04:35 [7611] [8] INFO: Connection closed by the box <127.0.0.1> 2011-07-12 19:04:35 [7611] [7] DEBUG: Thread 7 (gw/bb_smscconn.c:sms_router) terminates. 2011-07-12 19:04:35 [7611] [8] DEBUG: Thread 8 (gw/bb_boxc.c:function) terminates. 2011-07-12 19:04:36 [7611] [5] DEBUG: Thread 5 (gw/bb_boxc.c:smsboxc_run) terminates. 2011-07-12 19:04:36 [7611] [0] INFO: All flow threads have died, killing core 2011-07-12 19:04:36 [7611] [0] DEBUG: Waiting for 2 (gwlib/http.c:server_thread) to terminate 2011-07-12 19:04:36 [7611] [3] DEBUG: HTTP: No clients with requests, quitting. 2011-07-12 19:04:36 [7611] [3] DEBUG: Thread 3 (gw/bb_http.c:httpadmin_run) terminates. 2011-07-12 19:04:36 [7611] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) terminates. 2011-07-12 19:04:36 [7611] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) terminates. 2011-07-12 19:04:36 [7611] [0] DEBUG: final clean-up for SMSCConn 2011-07-12 19:04:36 [7611] [0] DEBUG: MO concatenated message handling cleaned up 2011-07-12 19:04:36 [7611] [0] INFO: Total WDP messages: received 0, sent 0 2011-07-12 19:04:36 [7611] [0] INFO: Total SMS messages: received 0, dlr 2, sent 1, dlr 0 2011-07-12 19:04:36 [7611] [0] DEBUG: Immutable octet strings: 258. >>> LOG kannel-sqlbox 2011-07-12 19:04:04 [7620] [0] INFO: Added logfile `/var/log/kannel/kannel-sqlbox.log' with level `0'. 2011-07-12 19:04:04 [7620] [0] INFO: MYSQL: Connected to server at localhost. 2011-07-12 19:04:04 [7620] [0] INFO: MYSQL: server version 5.0.92-community, client version 5.0.92. 2011-07-12 19:04:04 [7620] [0] DEBUG: Started thread 1 (sqlbox.c:sql_to_bearerbox) 2011-07-12 19:04:04 [7620] [1] DEBUG: Thread 1 (sqlbox.c:sql_to_bearerbox) maps to pid 7620. 2011-07-12 19:04:04 [7620] [1] DEBUG: Connecting to <127.0.0.1> 2011-07-12 19:04:04 [7620] [1] INFO: Connected to bearerbox at localhost port 13003. 2011-07-12 19:04:04 [7620] [1] DEBUG: Started thread 2 (sqlbox.c:bearerbox_to_sql) 2011-07-12 19:04:04 [7620] [2] DEBUG: Thread 2 (sqlbox.c:bearerbox_to_sql) maps to pid 7620. >>> LOG 2011-07-12 19:04:08 [7626] [0] INFO: Added logfile `/var/log/kannel/smsbox.log' with level `0'. 2011-07-12 19:04:08 [7626] [0] INFO: Logging accesses to '/var/log/kannel/access.log'. 2011-07-12 19:04:08 [7626] [0] INFO: Started access logfile `/var/log/kannel/access.log'. 2011-07-12 19:04:08 [7626] [0] INFO: HTTP: Opening server at port 13013. 2011-07-12 19:04:08 [7626] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller) 2011-07-12 19:04:08 [7626] [0] DEBUG: Started thread 2 (gwlib/http.c:server_thread) 2011-07-12 19:04:08 [7626] [0] INFO: Set up send sms service at port 13013 2011-07-12 19:04:08 [7626] [0] DEBUG: Started thread 3 (gw/smsbox.c:sendsms_thread) 2011-07-12 19:04:08 [7626] [0] DEBUG: ---------------------------------------------- 2011-07-12 19:04:08 [7626] [0] DEBUG: Kannel smsbox version 1.5.0 starting 2011-07-12 19:04:08 [7626] [3] DEBUG: Thread 3 (gw/smsbox.c:sendsms_thread) maps to pid 7626. 2011-07-12 19:04:08 [7626] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps to pid 7626. 2011-07-12 19:04:08 [7626] [0] DEBUG: dumping group (sendsms-user): 2011-07-12 19:04:08 [7626] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) maps to pid 7626. 2011-07-12 19:04:08 [7626] [0] DEBUG: <user-allow-ip> = <127.0.0.1> 2011-07-12 19:04:08 [7626] [2] DEBUG: HTTP: Including port 13013, fd 8 for polling in server thread 2011-07-12 19:04:08 [7626] [0] DEBUG: <omit-empty> = <1> 2011-07-12 19:04:08 [7626] [0] DEBUG: <name> = <users> 2011-07-12 19:04:08 [7626] [0] DEBUG: <user-deny-ip> = <*.*.*.*> 2011-07-12 19:04:08 [7626] [0] DEBUG: <group> = <sendsms-user> 2011-07-12 19:04:08 [7626] [0] DEBUG: <dlr-url> = <http://*.*.*.*/cgi-bin/dlr.php?to=%to&msisdn=%msisdn&status=%status&messagId=%messagId&scts=%scts> 2011-07-12 19:04:08 [7626] [0] DEBUG: <max-messages> = <3> 2011-07-12 19:04:08 [7626] [0] DEBUG: <forced-smsc> = <smpp-provider> 2011-07-12 19:04:08 [7626] [0] DEBUG: <username> = <username> 2011-07-12 19:04:08 [7626] [0] DEBUG: <concatenation> = <1> 2011-07-12 19:04:08 [7626] [0] DEBUG: <password> = <pwd> 2011-07-12 19:04:08 [7626] [0] DEBUG: Started thread 4 (gw/smsbox.c:obey_request_thread) 2011-07-12 19:04:08 [7626] [0] DEBUG: Started thread 5 (gw/smsbox.c:url_result_thread) 2011-07-12 19:04:08 [7626] [5] DEBUG: Thread 5 (gw/smsbox.c:url_result_thread) maps to pid 7626. 2011-07-12 19:04:08 [7626] [0] DEBUG: Started thread 6 (gw/smsbox.c:http_queue_thread) 2011-07-12 19:04:08 [7626] [0] DEBUG: Connecting to <127.0.0.1> 2011-07-12 19:04:08 [7626] [0] INFO: Connected to bearerbox at localhost port 13003. 2011-07-12 19:04:08 [7626] [0] DEBUG: Started thread 7 (gw/heartbeat.c:heartbeat_thread) 2011-07-12 19:04:08 [7626] [4] DEBUG: Thread 4 (gw/smsbox.c:obey_request_thread) maps to pid 7626. 2011-07-12 19:04:08 [7626] [6] DEBUG: Thread 6 (gw/smsbox.c:http_queue_thread) maps to pid 7626. 2011-07-12 19:04:08 [7626] [7] DEBUG: Thread 7 (gw/heartbeat.c:heartbeat_thread) maps to pid 7626. 2011-07-12 19:04:08 [7626] [4] INFO: Starting delivery report <default> from <3538****0000> 2011-07-12 19:04:08 [7626] [4] DEBUG: Started thread 8 (gwlib/fdset.c:poller) 2011-07-12 19:04:08 [7626] [8] DEBUG: Thread 8 (gwlib/fdset.c:poller) maps to pid 7626. 2011-07-12 19:04:08 [7626] [4] DEBUG: Started thread 9 (gwlib/http.c:write_request_thread) 2011-07-12 19:04:08 [7626] [9] DEBUG: Thread 9 (gwlib/http.c:write_request_thread) maps to pid 7626. 2011-07-12 19:04:08 [7626] [9] DEBUG: Queue contains 0 pending requests. 2011-07-12 19:04:08 [7626] [9] DEBUG: Parsing URL `http://*.*.*.*/cgi-bin/dlr.php?t': 2011-07-12 19:04:08 [7626] [9] DEBUG: Scheme: http:// 2011-07-12 19:04:08 [7626] [9] DEBUG: Host: *.*.*.* 2011-07-12 19:04:08 [7626] [9] DEBUG: Port: 80 2011-07-12 19:04:08 [7626] [9] DEBUG: Username: (null) 2011-07-12 19:04:08 [7626] [9] DEBUG: Password: (null) 2011-07-12 19:04:08 [7626] [9] DEBUG: Path: /cgi-bin/dlr.php 2011-07-12 19:04:08 [7626] [9] DEBUG: Query: t 2011-07-12 19:04:08 [7626] [9] DEBUG: Fragment: (null) 2011-07-12 19:04:08 [7626] [9] DEBUG: Connecting nonblocking to <*.*.*.*> 2011-07-12 19:04:08 [7626] [9] DEBUG: HTTP: Opening connection to `*.*.*.*:80' (fd=28). 2011-07-12 19:04:08 [7626] [9] DEBUG: Socket connecting 2011-07-12 19:04:08 [7626] [8] DEBUG: Get info about connecting socket 2011-07-12 19:04:08 [7626] [8] DEBUG: HTTP: Sending request: 2011-07-12 19:04:08 [7626] [8] DEBUG: Octet string at 0x1e1b58f0: 2011-07-12 19:04:08 [7626] [8] DEBUG: len: 108 2011-07-12 19:04:08 [7626] [8] DEBUG: size: 1024 2011-07-12 19:04:08 [7626] [8] DEBUG: immutable: 0 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 47 45 54 20 2f 63 67 69 2d 62 69 6e 2f 64 6c 72 GET /cgi-bin/dlr 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 2e 70 68 70 3f 74 20 48 54 54 50 2f 31 2e 31 0d .php?t HTTP/1.1. 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 0a 48 6f 73 74 3a 20 32 30 35 2e 32 35 31 2e 31 .Host: 205.251.1 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 32 39 2e 31 30 34 0d 0a 43 6f 6e 6e 65 63 74 69 29.104..Connecti 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 6f 6e 3a 20 6b 65 65 70 2d 61 6c 69 76 65 0d 0a on: keep-alive.. 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 55 73 65 72 2d 41 67 65 6e 74 3a 20 4b 61 6e 6e User-Agent: Kann 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 65 6c 2f 31 2e 35 2e 30 0d 0a 0d 0a el/1.5.0.... 2011-07-12 19:04:08 [7626] [8] DEBUG: Octet string dump ends. 2011-07-12 19:04:08 [7626] [8] DEBUG: HTTP: Status line: <HTTP/1.1 200 OK> 2011-07-12 19:04:08 [7626] [8] DEBUG: HTTP: Received response: 2011-07-12 19:04:08 [7626] [8] DEBUG: Octet string at 0x1e1b3700: 2011-07-12 19:04:08 [7626] [8] DEBUG: len: 154 2011-07-12 19:04:08 [7626] [8] DEBUG: size: 1024 2011-07-12 19:04:08 [7626] [8] DEBUG: immutable: 0 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 47 45 54 20 2f 63 67 69 2d 62 69 6e 2f 64 6c 72 GET /cgi-bin/dlr 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 2e 70 68 70 3f 74 20 48 54 54 50 2f 31 2e 31 0d .php?t HTTP/1.1. 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 0a 48 6f 73 74 3a 20 32 30 35 2e 32 35 31 2e 31 .Host: 205.251.1 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 32 39 2e 31 30 34 0d 0a 43 6f 6e 6e 65 63 74 69 29.104..Connecti 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 6f 6e 3a 20 6b 65 65 70 2d 61 6c 69 76 65 0d 0a on: keep-alive.. 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 55 73 65 72 2d 41 67 65 6e 74 3a 20 4b 61 6e 6e User-Agent: Kann 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 65 6c 2f 31 2e 35 2e 30 0d 0a 0d 0a el/1.5.0.... 2011-07-12 19:04:08 [7626] [8] DEBUG: Octet string dump ends. 2011-07-12 19:04:08 [7626] [8] DEBUG: HTTP: Status line: <HTTP/1.1 200 OK> 2011-07-12 19:04:08 [7626] [8] DEBUG: HTTP: Received response: 2011-07-12 19:04:08 [7626] [8] DEBUG: Octet string at 0x1e1b3700: 2011-07-12 19:04:08 [7626] [8] DEBUG: len: 154 2011-07-12 19:04:08 [7626] [8] DEBUG: size: 1024 2011-07-12 19:04:08 [7626] [8] DEBUG: immutable: 0 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 44 61 74 65 3a 20 54 75 65 2c 20 31 32 20 4a 75 Date: Tue, 12 Ju 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 6c 20 32 30 31 31 20 31 39 3a 30 34 3a 30 38 20 l 2011 19:04:08 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 47 4d 54 0d 0a 53 65 72 76 65 72 3a 20 41 70 61 GMT..Server: Apa 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 63 68 65 0d 0a 58 2d 50 6f 77 65 72 65 64 2d 42 che..X-Powered-B 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 79 3a 20 50 48 50 2f 35 2e 32 2e 31 37 0d 0a 43 y: PHP/5.2.17..C 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 6f 6e 6e 65 63 74 69 6f 6e 3a 20 63 6c 6f 73 65 onnection: close 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 0d 0a 54 72 61 6e 73 66 65 72 2d 45 6e 63 6f 64 ..Transfer-Encod 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 69 6e 67 3a 20 63 68 75 6e 6b 65 64 0d 0a 43 6f ing: chunked..Co 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 6e 74 65 6e 74 2d 54 79 70 65 3a 20 74 65 78 74 ntent-Type: text 2011-07-12 19:04:08 [7626] [8] DEBUG: data: 2f 68 74 6d 6c 0d 0a 0d 0a 0a /html..... 2011-07-12 19:04:08 [7626] [8] DEBUG: Octet string dump ends. 2011-07-12 19:04:35 [7626] [0] INFO: Bearerbox told us to die 2011-07-12 19:04:35 [7626] [0] INFO: Received (and handled?) 1 requests in 27 seconds (0.04 per second) 2011-07-12 19:04:35 [7626] [0] INFO: Kannel smsbox terminating. 2011-07-12 19:04:35 [7626] [7] DEBUG: Thread 7 (gw/heartbeat.c:heartbeat_thread) terminates. 2011-07-12 19:04:35 [7626] [0] DEBUG: Waiting for 2 (gwlib/http.c:server_thread) to terminate 2011-07-12 19:04:35 [7626] [3] DEBUG: HTTP: No clients with requests, quitting. 2011-07-12 19:04:35 [7626] [3] DEBUG: Thread 3 (gw/smsbox.c:sendsms_thread) terminates. 2011-07-12 19:04:35 [7626] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) terminates. 2011-07-12 19:04:35 [7626] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) terminates. 2011-07-12 19:04:35 [7626] [0] DEBUG: Waiting for 4 (gw/smsbox.c:obey_request_thread) to terminate 2011-07-12 19:04:35 [7626] [4] DEBUG: Thread 4 (gw/smsbox.c:obey_request_thread) terminates. 2011-07-12 19:04:35 [7626] [0] DEBUG: Waiting for 5 (gw/smsbox.c:url_result_thread) to terminate 2011-07-12 19:04:35 [7626] [5] DEBUG: Thread 5 (gw/smsbox.c:url_result_thread) terminates. 2011-07-12 19:04:35 [7626] [6] DEBUG: Thread 6 (gw/smsbox.c:http_queue_thread) terminates. 2011-07-12 19:04:35 [7626] [0] DEBUG: Waiting for 9 (gwlib/http.c:write_request_thread) to terminate 2011-07-12 19:04:35 [7626] [9] DEBUG: Thread 9 (gwlib/http.c:write_request_thread) terminates. 2011-07-12 19:04:35 [7626] [8] DEBUG: Thread 8 (gwlib/fdset.c:poller) terminates. 2011-07-12 19:04:35 [7626] [0] DEBUG: Immutable octet strings: 273. >>> LOG smpp-provider 2011-07-12 19:03:56 [7611] [6] DEBUG: Connecting to <an IP address> 2011-07-12 19:03:56 [7611] [6] DEBUG: SMPP[smpp-provider]: Sending PDU: 2011-07-12 19:03:56 [7611] [6] DEBUG: SMPP PDU 0x14540650 dump: 2011-07-12 19:03:56 [7611] [6] DEBUG: type_name: bind_transceiver 2011-07-12 19:03:56 [7611] [6] DEBUG: command_id: 9 = 0x00000009 2011-07-12 19:03:56 [7611] [6] DEBUG: command_status: 0 = 0x00000000 2011-07-12 19:03:56 [7611] [6] DEBUG: sequence_number: 1 = 0x00000001 2011-07-12 19:03:56 [7611] [6] DEBUG: system_id: "username" 2011-07-12 19:03:56 [7611] [6] DEBUG: password: "password" 2011-07-12 19:03:56 [7611] [6] DEBUG: system_type: "username" 2011-07-12 19:03:56 [7611] [6] DEBUG: interface_version: 52 = 0x00000034 2011-07-12 19:03:56 [7611] [6] DEBUG: addr_ton: 0 = 0x00000000 2011-07-12 19:03:56 [7611] [6] DEBUG: addr_npi: 0 = 0x00000000 2011-07-12 19:03:56 [7611] [6] DEBUG: address_range: NULL 2011-07-12 19:03:56 [7611] [6] DEBUG: SMPP PDU dump ends. 2011-07-12 19:03:57 [7611] [6] DEBUG: SMPP[smpp-provider]: Got PDU: 2011-07-12 19:03:57 [7611] [6] DEBUG: SMPP PDU 0x14540680 dump: 2011-07-12 19:03:57 [7611] [6] DEBUG: type_name: bind_transceiver_resp 2011-07-12 19:03:57 [7611] [6] DEBUG: command_id: 2147483657 = 0x80000009 2011-07-12 19:03:57 [7611] [6] DEBUG: command_status: 0 = 0x00000000 2011-07-12 19:03:57 [7611] [6] DEBUG: sequence_number: 1 = 0x00000001 2011-07-12 19:03:57 [7611] [6] DEBUG: system_id: "PB SMPP" 2011-07-12 19:03:57 [7611] [6] DEBUG: SMPP PDU dump ends. 2011-07-12 19:03:57 [7611] [6] DEBUG: SMPP[smpp-provider]: throughput (0.00,10.00) 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP[smpp-provider]: throughput (0.00,10.00) 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP[smpp-provider]: Sending PDU: 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP PDU 0x1453cc80 dump: 2011-07-12 19:04:04 [7611] [6] DEBUG: type_name: submit_sm 2011-07-12 19:04:04 [7611] [6] DEBUG: command_id: 4 = 0x00000004 2011-07-12 19:04:04 [7611] [6] DEBUG: command_status: 0 = 0x00000000 2011-07-12 19:04:04 [7611] [6] DEBUG: sequence_number: 2 = 0x00000002 2011-07-12 19:04:04 [7611] [6] DEBUG: service_type: NULL 2011-07-12 19:04:04 [7611] [6] DEBUG: source_addr_ton: 2 = 0x00000002 2011-07-12 19:04:04 [7611] [6] DEBUG: source_addr_npi: 1 = 0x00000001 2011-07-12 19:04:04 [7611] [6] DEBUG: source_addr: "3538****0000" 2011-07-12 19:04:04 [7611] [6] DEBUG: dest_addr_ton: 2 = 0x00000002 2011-07-12 19:04:04 [7611] [6] DEBUG: dest_addr_npi: 1 = 0x00000001 2011-07-12 19:04:04 [7611] [6] DEBUG: destination_addr: "3538*******" 2011-07-12 19:04:04 [7611] [6] DEBUG: esm_class: 3 = 0x00000003 2011-07-12 19:04:04 [7611] [6] DEBUG: protocol_id: 0 = 0x00000000 2011-07-12 19:04:04 [7611] [6] DEBUG: priority_flag: 0 = 0x00000000 2011-07-12 19:04:04 [7611] [6] DEBUG: schedule_delivery_time: NULL 2011-07-12 19:04:04 [7611] [6] DEBUG: validity_period: NULL 2011-07-12 19:04:04 [7611] [6] DEBUG: registered_delivery: 1 = 0x00000001 2011-07-12 19:04:04 [7611] [6] DEBUG: replace_if_present_flag: 0 = 0x00000000 2011-07-12 19:04:04 [7611] [6] DEBUG: data_coding: 0 = 0x00000000 2011-07-12 19:04:04 [7611] [6] DEBUG: sm_default_msg_id: 0 = 0x00000000 2011-07-12 19:04:04 [7611] [6] DEBUG: sm_length: 11 = 0x0000000b 2011-07-12 19:04:04 [7611] [6] DEBUG: short_message: "Hola mundo" 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP PDU dump ends. 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP[smpp-provider]: throughput (1.00,10.00) 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP[smpp-provider]: throughput (1.00,10.00) 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP[smpp-provider]: Got PDU: 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP PDU 0x1453cc80 dump: 2011-07-12 19:04:04 [7611] [6] DEBUG: type_name: submit_sm_resp 2011-07-12 19:04:04 [7611] [6] DEBUG: command_id: 2147483652 = 0x80000004 2011-07-12 19:04:04 [7611] [6] DEBUG: command_status: 0 = 0x00000000 2011-07-12 19:04:04 [7611] [6] DEBUG: sequence_number: 2 = 0x00000002 2011-07-12 19:04:04 [7611] [6] DEBUG: message_id: "024FEA6B" 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP PDU dump ends. 2011-07-12 19:04:04 [7611] [6] DEBUG: DLR[mysql]: Adding DLR smsc=smpp-provider, ts=38791787, src=3538****0000, dst=3538*******, mask=31, boxc=sqlbox 2011-07-12 19:04:04 [7611] [6] DEBUG: adding DLR entry into database 2011-07-12 19:04:04 [7611] [6] DEBUG: sql: INSERT INTO `verslag` (`smsc`, `ts`, `source`, `dst`, `service`, `url`, `mask`, `boxc_id`, `status`) VALUES (?, ?, ?, ?, ?, ?, ?, ?, 0) 2011-07-12 19:04:04 [7611] [6] DEBUG: SMSC[smpp-provider]: creating DLR message 2011-07-12 19:04:04 [7611] [6] DEBUG: SMSC[smpp-provider]: DLR = http://*.*.*.*/cgi-bin/dlr.php?to%3D%25to%26msisdn%3D%25msisdn%26status%3D%25status%26messagId%3D1008928%26scts%3D%25scts 2011-07-12 19:04:04 [7611] [6] DEBUG: SMPP[smpp-provider]: throughput (1.00,10.00) 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP[smpp-provider]: throughput (0.00,10.00) 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP[smpp-provider]: Got PDU: 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP PDU 0x14535a80 dump: 2011-07-12 19:04:08 [7611] [6] DEBUG: type_name: deliver_sm 2011-07-12 19:04:08 [7611] [6] DEBUG: command_id: 5 = 0x00000005 2011-07-12 19:04:08 [7611] [6] DEBUG: command_status: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: sequence_number: 1 = 0x00000001 2011-07-12 19:04:08 [7611] [6] DEBUG: service_type: NULL 2011-07-12 19:04:08 [7611] [6] DEBUG: source_addr_ton: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: source_addr_npi: 1 = 0x00000001 2011-07-12 19:04:08 [7611] [6] DEBUG: source_addr: "3538*******" 2011-07-12 19:04:08 [7611] [6] DEBUG: dest_addr_ton: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: dest_addr_npi: 1 = 0x00000001 2011-07-12 19:04:08 [7611] [6] DEBUG: source_addr: "3538*******" 2011-07-12 19:04:08 [7611] [6] DEBUG: dest_addr_ton: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: dest_addr_npi: 1 = 0x00000001 2011-07-12 19:04:08 [7611] [6] DEBUG: destination_addr: "353857720000" 2011-07-12 19:04:08 [7611] [6] DEBUG: esm_class: 4 = 0x00000004 2011-07-12 19:04:08 [7611] [6] DEBUG: protocol_id: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: priority_flag: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: schedule_delivery_time: NULL 2011-07-12 19:04:08 [7611] [6] DEBUG: validity_period: NULL 2011-07-12 19:04:08 [7611] [6] DEBUG: registered_delivery: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: replace_if_present_flag: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: data_coding: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: sm_default_msg_id: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: sm_length: 122 = 0x0000007a 2011-07-12 19:04:08 [7611] [6] DEBUG: short_message: 2011-07-12 19:04:08 [7611] [6] DEBUG: Octet string at 0x1453d340: 2011-07-12 19:04:08 [7611] [6] DEBUG: len: 122 2011-07-12 19:04:08 [7611] [6] DEBUG: size: 123 2011-07-12 19:04:08 [7611] [6] DEBUG: immutable: 0 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 69 64 3a 30 30 33 38 37 39 31 37 38 37 20 73 75 id:0038791787 su 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 62 3a 30 30 31 20 64 6c 76 72 64 3a 30 30 31 20 b:001 dlvrd:001 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 73 75 62 6d 69 74 20 64 61 74 65 3a 31 31 30 37 submit date:1107 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 31 32 32 31 30 34 20 64 6f 6e 65 20 64 61 74 65 122104 done date 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 3a 31 31 30 37 31 32 31 38 35 33 20 73 74 61 74 :1107121853 stat 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 3a 44 45 4c 49 56 52 44 20 65 72 72 3a 30 30 30 :DELIVRD err:000 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 20 74 65 78 74 3a 6e 6f 6e 65 20 20 20 20 20 20 text:none 2011-07-12 19:04:08 [7611] [6] DEBUG: data: 20 20 20 20 20 20 20 20 20 20 2011-07-12 19:04:08 [7611] [6] DEBUG: Octet string dump ends. 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP PDU dump ends. 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP[smpp-provider] handle_pdu, got DLR 2011-07-12 19:04:08 [7611] [6] DEBUG: DLR[mysql]: Looking for DLR smsc=smpp-provider, ts=38791787, dst=3538*******, type=1 2011-07-12 19:04:08 [7611] [6] DEBUG: sql: SELECT `mask`, `service`, `url`, `source`, `dst`, `boxc_id` FROM `verslag` WHERE `smsc`=? AND `ts`=? LIMIT 1 2011-07-12 19:04:08 [7611] [6] DEBUG: column=mask buffer_type=253 max_length=0 length=20 2011-07-12 19:04:08 [7611] [6] DEBUG: column=service buffer_type=253 max_length=0 length=40 2011-07-12 19:04:08 [7611] [6] DEBUG: column=url buffer_type=253 max_length=0 length=40 2011-07-12 19:04:08 [7611] [6] DEBUG: column=source buffer_type=253 max_length=0 length=20 2011-07-12 19:04:08 [7611] [6] DEBUG: column=dst buffer_type=253 max_length=0 length=20 2011-07-12 19:04:08 [7611] [6] DEBUG: column=boxc_id buffer_type=3 max_length=0 length=11 2011-07-12 19:04:08 [7611] [6] DEBUG: DLR[mysql]: created DLR message for URL <http://*.*.*.*/cgi-bin/dlr.php?t> 2011-07-12 19:04:08 [7611] [6] DEBUG: removing DLR from database 2011-07-12 19:04:08 [7611] [6] DEBUG: sql: DELETE FROM `verslag` WHERE `smsc`=? AND `ts`=? LIMIT 1 2011-07-12 19:04:08 [7611] [6] DEBUG: new group created `smpp' 2011-07-12 19:04:08 [7611] [6] DEBUG: group=`smpp' key=`dlr_err' value=`000' 2011-07-12 19:04:08 [7611] [6] WARNING: Could not route message to smsbox id <0>, smsbox is gone! 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP[smpp-provider]: Sending PDU: 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP PDU 0x14533dd0 dump: 2011-07-12 19:04:08 [7611] [6] DEBUG: type_name: deliver_sm_resp 2011-07-12 19:04:08 [7611] [6] DEBUG: command_id: 2147483653 = 0x80000005 2011-07-12 19:04:08 [7611] [6] DEBUG: command_status: 0 = 0x00000000 2011-07-12 19:04:08 [7611] [6] DEBUG: sequence_number: 1 = 0x00000001 2011-07-12 19:04:08 [7611] [6] DEBUG: message_id: NULL 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP PDU dump ends. 2011-07-12 19:04:08 [7611] [6] DEBUG: SMPP[smpp-provider]: throughput (0.00,10.00) 2011-07-12 19:04:26 [7611] [6] DEBUG: SMPP[smpp-provider]: Sending enquire link:
