Multipart DLR issue
"Rene Kluwen" <[email protected]>
| Newsgroups | gmane.comp.mobile.kannel.devel |
|---|---|
| Message-ID | <[email protected]> |
This is the setup:
KANNEL 1 KANNEL 2
CGI PUSH -- SMSBOX 1 -- BEARERBOX 1 ------ SMPP LINK ------ Open SMPPBOX --- BEARERBOX 2
I am working on smppbox sending multi-part messages via the same SMSC (on Kannel 2). I do this by reassembling the submit_sm pdu's in smppbox back to one large SMS and sending it to bearerbox as a whole.
This works now and will be submitted to svn shortly.
I keep track of which smpp id's the message originally consisted of and when I get a DLR, I send a deliver_sm for each of these pdu's.
As you can see in the log files (attached) the second PDU doesn't seem to be stored in the DLR database of bearerbox 1. What exactly is the procedure here to be followed?
I assume that if an sms message consists of multiple parts, each part needs to be matched with a corresponding DLR receipt. But it seems that Kannel only stores the first part in the DLR table and is not interested in the rest.
Thank you for your time,
== Rene
bearerbox1.log
(application/octet-stream, 18.7 KB)
2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00) 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Manually forced dest addr ton = 1, dest add npi = 1 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Sending PDU: 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU 0x127fcd0 dump: 2010-06-17 05:52:19 [6990] [11] DEBUG: type_name: submit_sm 2010-06-17 05:52:19 [6990] [11] DEBUG: command_id: 4 = 0x00000004 2010-06-17 05:52:19 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:52:19 [6990] [11] DEBUG: service_type: "play" 2010-06-17 05:52:19 [6990] [11] DEBUG: source_addr_ton: 5 = 0x00000005 2010-06-17 05:52:19 [6990] [11] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: source_addr: "gateway" 2010-06-17 05:52:19 [6990] [11] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:52:19 [6990] [11] DEBUG: dest_addr_npi: 1 = 0x00000001 2010-06-17 05:52:19 [6990] [11] DEBUG: destination_addr: "48609818400" 2010-06-17 05:52:19 [6990] [11] DEBUG: esm_class: 67 = 0x00000043 2010-06-17 05:52:19 [6990] [11] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:52:19 [6990] [11] DEBUG: validity_period: NULL 2010-06-17 05:52:19 [6990] [11] DEBUG: registered_delivery: 1 = 0x00000001 2010-06-17 05:52:19 [6990] [11] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sm_length: 159 = 0x0000009f 2010-06-17 05:52:19 [6990] [11] DEBUG: short_message: 2010-06-17 05:52:19 [6990] [11] DEBUG: Octet string at 0x125d410: 2010-06-17 05:52:19 [6990] [11] DEBUG: len: 159 2010-06-17 05:52:19 [6990] [11] DEBUG: size: 1024 2010-06-17 05:52:19 [6990] [11] DEBUG: immutable: 0 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 05 00 03 00 02 01 74 68 69 73 20 69 73 20 6c 6f ......this is lo 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 6e 67 20 6d 65 73 73 61 67 65 20 74 68 69 73 20 ng message this 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 69 73 20 6c 6f 6e 67 20 6d 65 73 73 61 67 65 20 is long message 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 74 68 69 73 20 69 73 20 6c 6f 6e 67 20 6d 65 73 this is long mes 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 73 61 67 65 20 74 68 69 73 20 69 73 20 6c 6f 6e sage this is lon 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 67 20 6d 65 73 73 61 67 65 20 74 68 69 73 20 69 g message this i 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 73 20 6c 6f 6e 67 20 6d 65 73 73 61 67 65 20 74 s long message t 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 68 69 73 20 69 73 20 6c 6f 6e 67 20 6d 65 73 73 his is long mess 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 61 67 65 20 74 68 69 73 20 69 73 20 6c 6f 6e 67 age this is long 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 20 6d 65 73 73 61 67 65 20 20 74 68 69 73 20 message this 2010-06-17 05:52:19 [6990] [11] DEBUG: Octet string dump ends. 2010-06-17 05:52:19 [6990] [11] DEBUG: more_messages_to_send: 1 = 0x00000001 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (1.00,0.00) 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Manually forced dest addr ton = 1, dest add npi = 1 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Sending PDU: 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU 0x125d140 dump: 2010-06-17 05:52:19 [6990] [11] DEBUG: type_name: submit_sm 2010-06-17 05:52:19 [6990] [11] DEBUG: command_id: 4 = 0x00000004 2010-06-17 05:52:19 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sequence_number: 3 = 0x00000003 2010-06-17 05:52:19 [6990] [11] DEBUG: service_type: "play" 2010-06-17 05:52:19 [6990] [11] DEBUG: source_addr_ton: 5 = 0x00000005 2010-06-17 05:52:19 [6990] [11] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: source_addr: "gateway" 2010-06-17 05:52:19 [6990] [11] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:52:19 [6990] [11] DEBUG: dest_addr_npi: 1 = 0x00000001 2010-06-17 05:52:19 [6990] [11] DEBUG: destination_addr: "48609818400" 2010-06-17 05:52:19 [6990] [11] DEBUG: esm_class: 67 = 0x00000043 2010-06-17 05:52:19 [6990] [11] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:52:19 [6990] [11] DEBUG: validity_period: NULL 2010-06-17 05:52:19 [6990] [11] DEBUG: registered_delivery: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sm_length: 42 = 0x0000002a 2010-06-17 05:52:19 [6990] [11] DEBUG: short_message: 2010-06-17 05:52:19 [6990] [11] DEBUG: Octet string at 0x127b190: 2010-06-17 05:52:19 [6990] [11] DEBUG: len: 42 2010-06-17 05:52:19 [6990] [11] DEBUG: size: 1024 2010-06-17 05:52:19 [6990] [11] DEBUG: immutable: 0 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 05 00 03 00 02 02 73 6f 6d 65 77 68 65 72 65 20 ......somewhere 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 68 65 72 65 20 69 73 20 73 65 63 6f 6e 64 20 70 here is second p 2010-06-17 05:52:19 [6990] [11] DEBUG: data: 61 72 74 20 6f 66 20 6d 73 67 art of msg 2010-06-17 05:52:19 [6990] [11] DEBUG: Octet string dump ends. 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (2.00,0.00) 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (2.00,0.00) 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Got PDU: 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU 0x125d140 dump: 2010-06-17 05:52:19 [6990] [11] DEBUG: type_name: submit_sm_resp 2010-06-17 05:52:19 [6990] [11] DEBUG: command_id: 2147483652 = 0x80000004 2010-06-17 05:52:19 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:52:19 [6990] [11] DEBUG: message_id: "13497cc3" 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:19 [6990] [11] DEBUG: DLR[mysql]: Adding DLR smsc=Ekonomiczne_sms, ts=13497cc3, src=gateway, dst=48609818400, mask=31, boxc=smsbox 2010-06-17 05:52:19 [6990] [11] DEBUG: adding DLR entry into database 2010-06-17 05:52:19 [6990] [11] DEBUG: sql: INSERT INTO `dlr` (`smsc`, `ts`, `source`, `destination`, `service`, `url`, `mask`, `boxc`, `status`) VALUES (?, ?, ?, ?, ?, ?, ?, ?, 0) 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (2.00,0.00) 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (2.00,0.00) 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Got PDU: 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU 0x125d140 dump: 2010-06-17 05:52:19 [6990] [11] DEBUG: type_name: submit_sm_resp 2010-06-17 05:52:19 [6990] [11] DEBUG: command_id: 2147483652 = 0x80000004 2010-06-17 05:52:19 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:19 [6990] [11] DEBUG: sequence_number: 3 = 0x00000003 2010-06-17 05:52:19 [6990] [11] DEBUG: message_id: "ff7a75f8" 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:19 [6990] [11] DEBUG: SMSC[Ekonomiczne_sms]: creating DLR message 2010-06-17 05:52:19 [6990] [11] DEBUG: SMSC[Ekonomiczne_sms]: DLR = http://localhost/dlr.php?msgid=bf704e70a6cfea3c60357ec482aeb3e0&status=%d&donedate=%T&extid=%F 2010-06-17 05:52:19 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (2.00,0.00) 2010-06-17 05:52:24 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Sending enquire link: 2010-06-17 05:52:24 [6990] [11] DEBUG: SMPP PDU 0x125d140 dump: 2010-06-17 05:52:24 [6990] [11] DEBUG: type_name: enquire_link 2010-06-17 05:52:24 [6990] [11] DEBUG: command_id: 21 = 0x00000015 2010-06-17 05:52:24 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:24 [6990] [11] DEBUG: sequence_number: 4 = 0x00000004 2010-06-17 05:52:24 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:24 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00) 2010-06-17 05:52:25 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00) 2010-06-17 05:52:25 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Got PDU: 2010-06-17 05:52:25 [6990] [11] DEBUG: SMPP PDU 0x125d140 dump: 2010-06-17 05:52:25 [6990] [11] DEBUG: type_name: enquire_link_resp 2010-06-17 05:52:25 [6990] [11] DEBUG: command_id: 2147483669 = 0x80000015 2010-06-17 05:52:25 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:25 [6990] [11] DEBUG: sequence_number: 4 = 0x00000004 2010-06-17 05:52:25 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:25 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00) 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00) 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Got PDU: 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP PDU 0x125d140 dump: 2010-06-17 05:52:31 [6990] [11] DEBUG: type_name: deliver_sm 2010-06-17 05:52:31 [6990] [11] DEBUG: command_id: 5 = 0x00000005 2010-06-17 05:52:31 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: sequence_number: 1 = 0x00000001 2010-06-17 05:52:31 [6990] [11] DEBUG: service_type: NULL 2010-06-17 05:52:31 [6990] [11] DEBUG: source_addr_ton: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: source_addr: "+48790516784" 2010-06-17 05:52:31 [6990] [11] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:52:31 [6990] [11] DEBUG: dest_addr_npi: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: destination_addr: "48609818400" 2010-06-17 05:52:31 [6990] [11] DEBUG: esm_class: 15 = 0x0000000f 2010-06-17 05:52:31 [6990] [11] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:52:31 [6990] [11] DEBUG: validity_period: NULL 2010-06-17 05:52:31 [6990] [11] DEBUG: registered_delivery: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: sm_length: 112 = 0x00000070 2010-06-17 05:52:31 [6990] [11] DEBUG: short_message: 2010-06-17 05:52:31 [6990] [11] DEBUG: Octet string at 0x125d770: 2010-06-17 05:52:31 [6990] [11] DEBUG: len: 112 2010-06-17 05:52:31 [6990] [11] DEBUG: size: 113 2010-06-17 05:52:31 [6990] [11] DEBUG: immutable: 0 2010-06-17 05:52:31 [6990] [11] DEBUG: data: 69 64 3a 31 33 34 39 37 63 63 33 20 73 75 62 3a id:13497cc3 sub: 2010-06-17 05:52:31 [6990] [11] DEBUG: data: 30 30 31 20 64 6c 76 72 64 3a 30 30 31 20 73 75 001 dlvrd:001 su 2010-06-17 05:52:31 [6990] [11] DEBUG: data: 62 6d 69 74 20 64 61 74 65 3a 31 32 37 36 37 34 bmit date:127674 2010-06-17 05:52:31 [6990] [11] DEBUG: data: 36 36 32 30 20 64 6f 6e 65 20 64 61 74 65 3a 31 6620 done date:1 2010-06-17 05:52:31 [6990] [11] DEBUG: data: 32 37 36 37 34 36 36 32 30 20 73 74 61 74 3a 44 276746620 stat:D 2010-06-17 05:52:31 [6990] [11] DEBUG: data: 45 4c 49 56 52 44 20 65 72 72 3a 30 30 30 20 74 ELIVRD err:000 t 2010-06-17 05:52:31 [6990] [11] DEBUG: data: 65 78 74 3a 20 20 20 20 20 53 75 63 63 65 73 73 ext: Success 2010-06-17 05:52:31 [6990] [11] DEBUG: Octet string dump ends. 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms] handle_pdu, got DLR 2010-06-17 05:52:31 [6990] [11] DEBUG: DLR[mysql]: Looking for DLR smsc=Ekonomiczne_sms, ts=13497cc3, dst=+48790516784, type=1 2010-06-17 05:52:31 [6990] [11] DEBUG: sql: SELECT `mask`, `service`, `url`, `source`, `destination`, `boxc` FROM `dlr` WHERE `smsc`=? AND `ts`=? LIMIT 1 2010-06-17 05:52:31 [6990] [11] DEBUG: column=mask buffer_type=253 max_length=0 length=255 2010-06-17 05:52:31 [6990] [11] DEBUG: column=service buffer_type=253 max_length=0 length=255 2010-06-17 05:52:31 [6990] [11] DEBUG: column=url buffer_type=253 max_length=0 length=500 2010-06-17 05:52:31 [6990] [11] DEBUG: column=source buffer_type=253 max_length=0 length=255 2010-06-17 05:52:31 [6990] [11] DEBUG: column=destination buffer_type=253 max_length=0 length=255 2010-06-17 05:52:31 [6990] [11] DEBUG: column=boxc buffer_type=253 max_length=0 length=255 2010-06-17 05:52:31 [6990] [11] DEBUG: DLR[mysql]: created DLR message for URL <http://localhost/dlr.php?msgid=bf704e70a6cfea3c60357ec482aeb3e0&status=%d&donedate=%T&extid=%F> 2010-06-17 05:52:31 [6990] [11] DEBUG: removing DLR from database 2010-06-17 05:52:31 [6990] [11] DEBUG: sql: DELETE FROM `dlr` WHERE `smsc`=? AND `ts`=? LIMIT 1 2010-06-17 05:52:31 [6990] [11] DEBUG: new group created `smpp' 2010-06-17 05:52:31 [6990] [11] DEBUG: group=`smpp' key=`dlr_err' value=`000' 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Sending PDU: 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP PDU 0x125ca20 dump: 2010-06-17 05:52:31 [6990] [11] DEBUG: type_name: deliver_sm_resp 2010-06-17 05:52:31 [6990] [11] DEBUG: command_id: 2147483653 = 0x80000005 2010-06-17 05:52:31 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:31 [6990] [11] DEBUG: sequence_number: 1 = 0x00000001 2010-06-17 05:52:31 [6990] [11] DEBUG: message_id: NULL 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:31 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00) 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00) 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Got PDU: 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP PDU 0x125ca20 dump: 2010-06-17 05:52:32 [6990] [11] DEBUG: type_name: deliver_sm 2010-06-17 05:52:32 [6990] [11] DEBUG: command_id: 5 = 0x00000005 2010-06-17 05:52:32 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:52:32 [6990] [11] DEBUG: service_type: NULL 2010-06-17 05:52:32 [6990] [11] DEBUG: source_addr_ton: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: source_addr: "+48790516784" 2010-06-17 05:52:32 [6990] [11] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:52:32 [6990] [11] DEBUG: dest_addr_npi: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: destination_addr: "48609818400" 2010-06-17 05:52:32 [6990] [11] DEBUG: esm_class: 15 = 0x0000000f 2010-06-17 05:52:32 [6990] [11] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:52:32 [6990] [11] DEBUG: validity_period: NULL 2010-06-17 05:52:32 [6990] [11] DEBUG: registered_delivery: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: sm_length: 112 = 0x00000070 2010-06-17 05:52:32 [6990] [11] DEBUG: short_message: 2010-06-17 05:52:32 [6990] [11] DEBUG: Octet string at 0x125d350: 2010-06-17 05:52:32 [6990] [11] DEBUG: len: 112 2010-06-17 05:52:32 [6990] [11] DEBUG: size: 113 2010-06-17 05:52:32 [6990] [11] DEBUG: immutable: 0 2010-06-17 05:52:32 [6990] [11] DEBUG: data: 69 64 3a 66 66 37 61 37 35 66 38 20 73 75 62 3a id:ff7a75f8 sub: 2010-06-17 05:52:32 [6990] [11] DEBUG: data: 30 30 31 20 64 6c 76 72 64 3a 30 30 31 20 73 75 001 dlvrd:001 su 2010-06-17 05:52:32 [6990] [11] DEBUG: data: 62 6d 69 74 20 64 61 74 65 3a 31 32 37 36 37 34 bmit date:127674 2010-06-17 05:52:32 [6990] [11] DEBUG: data: 36 36 32 30 20 64 6f 6e 65 20 64 61 74 65 3a 31 6620 done date:1 2010-06-17 05:52:32 [6990] [11] DEBUG: data: 32 37 36 37 34 36 36 32 30 20 73 74 61 74 3a 44 276746620 stat:D 2010-06-17 05:52:32 [6990] [11] DEBUG: data: 45 4c 49 56 52 44 20 65 72 72 3a 30 30 30 20 74 ELIVRD err:000 t 2010-06-17 05:52:32 [6990] [11] DEBUG: data: 65 78 74 3a 20 20 20 20 20 53 75 63 63 65 73 73 ext: Success 2010-06-17 05:52:32 [6990] [11] DEBUG: Octet string dump ends. 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms] handle_pdu, got DLR 2010-06-17 05:52:32 [6990] [11] DEBUG: DLR[mysql]: Looking for DLR smsc=Ekonomiczne_sms, ts=ff7a75f8, dst=+48790516784, type=1 2010-06-17 05:52:32 [6990] [11] DEBUG: sql: SELECT `mask`, `service`, `url`, `source`, `destination`, `boxc` FROM `dlr` WHERE `smsc`=? AND `ts`=? LIMIT 1 2010-06-17 05:52:32 [6990] [11] DEBUG: column=mask buffer_type=253 max_length=0 length=255 2010-06-17 05:52:32 [6990] [11] DEBUG: column=service buffer_type=253 max_length=0 length=255 2010-06-17 05:52:32 [6990] [11] DEBUG: column=url buffer_type=253 max_length=0 length=500 2010-06-17 05:52:32 [6990] [11] DEBUG: column=source buffer_type=253 max_length=0 length=255 2010-06-17 05:52:32 [6990] [11] DEBUG: column=destination buffer_type=253 max_length=0 length=255 2010-06-17 05:52:32 [6990] [11] DEBUG: column=boxc buffer_type=253 max_length=0 length=255 2010-06-17 05:52:32 [6990] [11] WARNING: DLR[mysql]: DLR from SMSC<Ekonomiczne_sms> for DST<+48790516784> not found. 2010-06-17 05:52:32 [6990] [11] ERROR: SMPP[Ekonomiczne_sms]: got DLR but could not find message or was not interested in it id<ff7a75f8> dst<+48790516784>, type<1> 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: Sending PDU: 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP PDU 0x1240050 dump: 2010-06-17 05:52:32 [6990] [11] DEBUG: type_name: deliver_sm_resp 2010-06-17 05:52:32 [6990] [11] DEBUG: command_id: 2147483653 = 0x80000005 2010-06-17 05:52:32 [6990] [11] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:52:32 [6990] [11] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:52:32 [6990] [11] DEBUG: message_id: NULL 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP PDU dump ends. 2010-06-17 05:52:32 [6990] [11] DEBUG: SMPP[Ekonomiczne_sms]: throughput (0.00,0.00)
smppbox2.log
(application/octet-stream, 26.7 KB)
2010-06-17 05:50:08 [1662] [2] DEBUG: Optional parameter tag (0x0426) 2010-06-17 05:50:08 [1662] [2] DEBUG: Optional parameter length read as 1 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP[main]: Got PDU: 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU 0x70de80 dump: 2010-06-17 05:50:08 [1662] [2] DEBUG: type_name: submit_sm 2010-06-17 05:50:08 [1662] [2] DEBUG: command_id: 4 = 0x00000004 2010-06-17 05:50:08 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:50:08 [1662] [2] DEBUG: service_type: "play" 2010-06-17 05:50:08 [1662] [2] DEBUG: source_addr_ton: 5 = 0x00000005 2010-06-17 05:50:08 [1662] [2] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: source_addr: "gateway" 2010-06-17 05:50:08 [1662] [2] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:50:08 [1662] [2] DEBUG: dest_addr_npi: 1 = 0x00000001 2010-06-17 05:50:08 [1662] [2] DEBUG: destination_addr: "48609818400" 2010-06-17 05:50:08 [1662] [2] DEBUG: esm_class: 67 = 0x00000043 2010-06-17 05:50:08 [1662] [2] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:50:08 [1662] [2] DEBUG: validity_period: NULL 2010-06-17 05:50:08 [1662] [2] DEBUG: registered_delivery: 1 = 0x00000001 2010-06-17 05:50:08 [1662] [2] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sm_length: 159 = 0x0000009f 2010-06-17 05:50:08 [1662] [2] DEBUG: short_message: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70dde0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 159 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 160 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 05 00 03 00 02 01 74 68 69 73 20 69 73 20 6c 6f ......this is lo 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 6e 67 20 6d 65 73 73 61 67 65 20 74 68 69 73 20 ng message this 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 69 73 20 6c 6f 6e 67 20 6d 65 73 73 61 67 65 20 is long message 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 74 68 69 73 20 69 73 20 6c 6f 6e 67 20 6d 65 73 this is long mes 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 73 61 67 65 20 74 68 69 73 20 69 73 20 6c 6f 6e sage this is lon 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 67 20 6d 65 73 73 61 67 65 20 74 68 69 73 20 69 g message this i 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 73 20 6c 6f 6e 67 20 6d 65 73 73 61 67 65 20 74 s long message t 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 68 69 73 20 69 73 20 6c 6f 6e 67 20 6d 65 73 73 his is long mess 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 61 67 65 20 74 68 69 73 20 69 73 20 6c 6f 6e 67 age this is long 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 20 6d 65 73 73 61 67 65 20 20 74 68 69 73 20 message this 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: more_messages_to_send: 1 = 0x00000001 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP[main]: UDH length read as 6 2010-06-17 05:50:08 [1662] [2] DEBUG: assemble multi-part message. 2010-06-17 05:50:08 [1662] [2] DEBUG: Putting key: +48609818400-0. 2010-06-17 05:50:08 [1662] [2] DEBUG: received 1 of 2. 2010-06-17 05:50:08 [1662] [2] DEBUG: Msg object at 0x70a740: 2010-06-17 05:50:08 [1662] [2] DEBUG: type: sms 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.sender: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70e090: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 7 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 8 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 67 61 74 65 77 61 79 gateway 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.receiver: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70dd90: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 12 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 1024 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 2b 34 38 36 30 39 38 31 38 34 30 30 +48609818400 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.udhdata: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70de10: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 6 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 7 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 05 00 03 00 02 01 ...... 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.msgdata: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70dde0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 153 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 160 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 74 68 69 73 20 69 73 20 6c 6f 6e 67 20 6d 65 73 this is long mes 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 73 61 67 65 20 74 68 69 73 20 69 73 20 6c 6f 6e sage this is lon 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 67 20 6d 65 73 73 61 67 65 20 74 68 69 73 20 69 g message this i 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 73 20 6c 6f 6e 67 20 6d 65 73 73 61 67 65 20 74 s long message t 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 68 69 73 20 69 73 20 6c 6f 6e 67 20 6d 65 73 73 his is long mess 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 61 67 65 20 74 68 69 73 20 69 73 20 6c 6f 6e 67 age this is long 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 20 6d 65 73 73 61 67 65 20 74 68 69 73 20 69 73 message this is 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 20 6c 6f 6e 67 20 6d 65 73 73 61 67 65 20 74 68 long message th 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 69 73 20 69 73 20 6c 6f 6e 67 20 6d 65 73 73 61 is is long messa 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 67 65 20 20 74 68 69 73 20 ge this 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.time: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.smsc_id: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70a8c0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 4 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 5 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 70 6c 61 79 play 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.smsc_number: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.foreign_id: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.service: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.account: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.id: 13497cc3-2c82-4df3-a6fa-d3aaf0da8242 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.sms_type: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.mclass: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.mwi: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.coding: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.compress: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.validity: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.deferred: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.dlr_mask: 3 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.dlr_url: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.pid: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.alt_dcs: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.rpi: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.charset: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.boxc_id: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70b3c0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 4 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 5 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 6d 61 69 6e main 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.binfo: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70e040: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 4 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 5 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 70 6c 61 79 play 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.msg_left: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.split_parts: (nil) 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.priority: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.resend_try: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.resend_time: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.meta_data: 2010-06-17 05:50:08 [1662] [2] DEBUG: Msg object ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP[main]: Sending PDU: 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU 0x70b410 dump: 2010-06-17 05:50:08 [1662] [2] DEBUG: type_name: submit_sm_resp 2010-06-17 05:50:08 [1662] [2] DEBUG: command_id: 2147483652 = 0x80000004 2010-06-17 05:50:08 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:50:08 [1662] [2] DEBUG: message_id: "13497cc3" 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP[main]: Got PDU: 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU 0x70de80 dump: 2010-06-17 05:50:08 [1662] [2] DEBUG: type_name: submit_sm 2010-06-17 05:50:08 [1662] [2] DEBUG: command_id: 4 = 0x00000004 2010-06-17 05:50:08 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sequence_number: 3 = 0x00000003 2010-06-17 05:50:08 [1662] [2] DEBUG: service_type: "play" 2010-06-17 05:50:08 [1662] [2] DEBUG: source_addr_ton: 5 = 0x00000005 2010-06-17 05:50:08 [1662] [2] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: source_addr: "gateway" 2010-06-17 05:50:08 [1662] [2] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:50:08 [1662] [2] DEBUG: dest_addr_npi: 1 = 0x00000001 2010-06-17 05:50:08 [1662] [2] DEBUG: destination_addr: "48609818400" 2010-06-17 05:50:08 [1662] [2] DEBUG: esm_class: 67 = 0x00000043 2010-06-17 05:50:08 [1662] [2] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:50:08 [1662] [2] DEBUG: validity_period: NULL 2010-06-17 05:50:08 [1662] [2] DEBUG: registered_delivery: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sm_length: 42 = 0x0000002a 2010-06-17 05:50:08 [1662] [2] DEBUG: short_message: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70b7b0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 42 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 43 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 05 00 03 00 02 02 73 6f 6d 65 77 68 65 72 65 20 ......somewhere 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 68 65 72 65 20 69 73 20 73 65 63 6f 6e 64 20 70 here is second p 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 61 72 74 20 6f 66 20 6d 73 67 art of msg 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP[main]: UDH length read as 6 2010-06-17 05:50:08 [1662] [2] DEBUG: assemble multi-part message. 2010-06-17 05:50:08 [1662] [2] DEBUG: received 2 of 2. 2010-06-17 05:50:08 [1662] [2] DEBUG: received all parts of multi-part message. 2010-06-17 05:50:08 [1662] [2] DEBUG: multi-part message, length: 189. 2010-06-17 05:50:08 [1662] [2] DEBUG: Msg object at 0x70e310: 2010-06-17 05:50:08 [1662] [2] DEBUG: type: sms 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.sender: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70b730: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 7 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 8 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 67 61 74 65 77 61 79 gateway 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.receiver: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70b760: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 12 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 1024 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 2b 34 38 36 30 39 38 31 38 34 30 30 +48609818400 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.udhdata: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70b6c0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 6 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 7 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 05 00 03 00 02 02 ...... 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.msgdata: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70b7b0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 36 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 43 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 73 6f 6d 65 77 68 65 72 65 20 68 65 72 65 20 69 somewhere here i 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 73 20 73 65 63 6f 6e 64 20 70 61 72 74 20 6f 66 s second part of 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 20 6d 73 67 msg 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.time: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.smsc_id: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70e9a0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 4 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 5 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 70 6c 61 79 play 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.smsc_number: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.foreign_id: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.service: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.account: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.id: ff7a75f8-3ec7-43ba-9883-5a303ad26537 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.sms_type: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.mclass: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.mwi: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.coding: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.compress: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.validity: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.deferred: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.dlr_mask: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.dlr_url: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.pid: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.alt_dcs: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.rpi: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.charset: 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.boxc_id: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x729ce0: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 4 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 5 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 6d 61 69 6e main 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.binfo: 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string at 0x70b670: 2010-06-17 05:50:08 [1662] [2] DEBUG: len: 4 2010-06-17 05:50:08 [1662] [2] DEBUG: size: 5 2010-06-17 05:50:08 [1662] [2] DEBUG: immutable: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: data: 70 6c 61 79 play 2010-06-17 05:50:08 [1662] [2] DEBUG: Octet string dump ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.msg_left: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.split_parts: (nil) 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.priority: 0 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.resend_try: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.resend_time: -1 2010-06-17 05:50:08 [1662] [2] DEBUG: sms.meta_data: 2010-06-17 05:50:08 [1662] [2] DEBUG: Msg object ends. 2010-06-17 05:50:08 [1662] [2] DEBUG: DLR[mysql]: Adding DLR smsc=main, ts=13497cc3, src=gateway, dst=+48609818400, mask=3, boxc=main 2010-06-17 05:50:08 [1662] [2] DEBUG: adding DLR entry into database 2010-06-17 05:50:08 [1662] [2] DEBUG: sql: INSERT INTO `dlr` (`smsc`, `ts`, `source`, `destination`, `service`, `url`, `mask`, `boxc`, `status`) VALUES (?, ?, ?, ?, ?, ?, ?, ?, 0) 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP[main]: Sending PDU: 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU 0x729d30 dump: 2010-06-17 05:50:08 [1662] [2] DEBUG: type_name: submit_sm_resp 2010-06-17 05:50:08 [1662] [2] DEBUG: command_id: 2147483652 = 0x80000004 2010-06-17 05:50:08 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:08 [1662] [2] DEBUG: sequence_number: 3 = 0x00000003 2010-06-17 05:50:08 [1662] [2] DEBUG: message_id: "ff7a75f8" 2010-06-17 05:50:08 [1662] [2] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:14 [1662] [2] DEBUG: SMPP[main]: Got PDU: 2010-06-17 05:50:14 [1662] [2] DEBUG: SMPP PDU 0x70de80 dump: 2010-06-17 05:50:14 [1662] [2] DEBUG: type_name: enquire_link 2010-06-17 05:50:14 [1662] [2] DEBUG: command_id: 21 = 0x00000015 2010-06-17 05:50:14 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:14 [1662] [2] DEBUG: sequence_number: 4 = 0x00000004 2010-06-17 05:50:14 [1662] [2] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:14 [1662] [2] DEBUG: SMPP[main]: Sending PDU: 2010-06-17 05:50:14 [1662] [2] DEBUG: SMPP PDU 0x70a690 dump: 2010-06-17 05:50:14 [1662] [2] DEBUG: type_name: enquire_link_resp 2010-06-17 05:50:14 [1662] [2] DEBUG: command_id: 2147483669 = 0x80000015 2010-06-17 05:50:14 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:14 [1662] [2] DEBUG: sequence_number: 4 = 0x00000004 2010-06-17 05:50:14 [1662] [2] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:20 [1662] [1] INFO: We received an SMS message. 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP[main]: Manually forced source addr ton = 0, source add npi = 0 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP[main]: Manually forced dest addr ton = 0, dest add npi = 0 2010-06-17 05:50:20 [1662] [1] DEBUG: DLR[mysql]: Looking for DLR smsc=main, ts=13497cc3, dst=+48609818400, type=1 2010-06-17 05:50:20 [1662] [1] DEBUG: sql: SELECT `mask`, `service`, `url`, `source`, `destination`, `boxc` FROM `dlr` WHERE `smsc`=? AND `ts`=? AND `destination`=? LIMIT 1 2010-06-17 05:50:20 [1662] [1] DEBUG: column=mask buffer_type=253 max_length=0 length=255 2010-06-17 05:50:20 [1662] [1] DEBUG: column=service buffer_type=253 max_length=0 length=255 2010-06-17 05:50:20 [1662] [1] DEBUG: column=url buffer_type=253 max_length=0 length=500 2010-06-17 05:50:20 [1662] [1] DEBUG: column=source buffer_type=253 max_length=0 length=255 2010-06-17 05:50:20 [1662] [1] DEBUG: column=destination buffer_type=253 max_length=0 length=255 2010-06-17 05:50:20 [1662] [1] DEBUG: column=boxc buffer_type=253 max_length=0 length=255 2010-06-17 05:50:20 [1662] [1] DEBUG: DLR[mysql]: created DLR message for URL <13497cc3;13497cc3;ff7a75f8> 2010-06-17 05:50:20 [1662] [1] DEBUG: removing DLR from database 2010-06-17 05:50:20 [1662] [1] DEBUG: sql: DELETE FROM `dlr` WHERE `smsc`=? AND `ts`=? AND `destination`=? LIMIT 1 2010-06-17 05:50:20 [1662] [1] DEBUG: DLR for multipart message: sending 13497cc3. 2010-06-17 05:50:20 [1662] [1] DEBUG: DLR for multipart message: sending ff7a75f8. 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP[main]: Sending PDU: 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP PDU 0x72c810 dump: 2010-06-17 05:50:20 [1662] [1] DEBUG: type_name: deliver_sm 2010-06-17 05:50:20 [1662] [1] DEBUG: command_id: 5 = 0x00000005 2010-06-17 05:50:20 [1662] [1] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: sequence_number: 1 = 0x00000001 2010-06-17 05:50:20 [1662] [1] DEBUG: service_type: NULL 2010-06-17 05:50:20 [1662] [1] DEBUG: source_addr_ton: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: source_addr: "+48790516784" 2010-06-17 05:50:20 [1662] [1] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:50:20 [1662] [1] DEBUG: dest_addr_npi: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: destination_addr: "48609818400" 2010-06-17 05:50:20 [1662] [1] DEBUG: esm_class: 15 = 0x0000000f 2010-06-17 05:50:20 [1662] [1] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:50:20 [1662] [1] DEBUG: validity_period: NULL 2010-06-17 05:50:20 [1662] [1] DEBUG: registered_delivery: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: sm_length: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: short_message: 2010-06-17 05:50:20 [1662] [1] DEBUG: Octet string at 0x72c650: 2010-06-17 05:50:20 [1662] [1] DEBUG: len: 112 2010-06-17 05:50:20 [1662] [1] DEBUG: size: 1024 2010-06-17 05:50:20 [1662] [1] DEBUG: immutable: 0 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 69 64 3a 31 33 34 39 37 63 63 33 20 73 75 62 3a id:13497cc3 sub: 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 30 30 31 20 64 6c 76 72 64 3a 30 30 31 20 73 75 001 dlvrd:001 su 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 62 6d 69 74 20 64 61 74 65 3a 31 32 37 36 37 34 bmit date:127674 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 36 36 32 30 20 64 6f 6e 65 20 64 61 74 65 3a 31 6620 done date:1 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 32 37 36 37 34 36 36 32 30 20 73 74 61 74 3a 44 276746620 stat:D 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 45 4c 49 56 52 44 20 65 72 72 3a 30 30 30 20 74 ELIVRD err:000 t 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 65 78 74 3a 20 20 20 20 20 53 75 63 63 65 73 73 ext: Success 2010-06-17 05:50:20 [1662] [1] DEBUG: Octet string dump ends. 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP[main]: Sending PDU: 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP PDU 0x729d30 dump: 2010-06-17 05:50:20 [1662] [1] DEBUG: type_name: deliver_sm 2010-06-17 05:50:20 [1662] [1] DEBUG: command_id: 5 = 0x00000005 2010-06-17 05:50:20 [1662] [1] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:50:20 [1662] [1] DEBUG: service_type: NULL 2010-06-17 05:50:20 [1662] [1] DEBUG: source_addr_ton: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: source_addr_npi: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: source_addr: "+48790516784" 2010-06-17 05:50:20 [1662] [1] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-06-17 05:50:20 [1662] [1] DEBUG: dest_addr_npi: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: destination_addr: "48609818400" 2010-06-17 05:50:20 [1662] [1] DEBUG: esm_class: 15 = 0x0000000f 2010-06-17 05:50:20 [1662] [1] DEBUG: protocol_id: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: priority_flag: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: schedule_delivery_time: NULL 2010-06-17 05:50:20 [1662] [1] DEBUG: validity_period: NULL 2010-06-17 05:50:20 [1662] [1] DEBUG: registered_delivery: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: data_coding: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: sm_length: 0 = 0x00000000 2010-06-17 05:50:20 [1662] [1] DEBUG: short_message: 2010-06-17 05:50:20 [1662] [1] DEBUG: Octet string at 0x70b740: 2010-06-17 05:50:20 [1662] [1] DEBUG: len: 112 2010-06-17 05:50:20 [1662] [1] DEBUG: size: 1024 2010-06-17 05:50:20 [1662] [1] DEBUG: immutable: 0 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 69 64 3a 66 66 37 61 37 35 66 38 20 73 75 62 3a id:ff7a75f8 sub: 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 30 30 31 20 64 6c 76 72 64 3a 30 30 31 20 73 75 001 dlvrd:001 su 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 62 6d 69 74 20 64 61 74 65 3a 31 32 37 36 37 34 bmit date:127674 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 36 36 32 30 20 64 6f 6e 65 20 64 61 74 65 3a 31 6620 done date:1 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 32 37 36 37 34 36 36 32 30 20 73 74 61 74 3a 44 276746620 stat:D 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 45 4c 49 56 52 44 20 65 72 72 3a 30 30 30 20 74 ELIVRD err:000 t 2010-06-17 05:50:20 [1662] [1] DEBUG: data: 65 78 74 3a 20 20 20 20 20 53 75 63 63 65 73 73 ext: Success 2010-06-17 05:50:20 [1662] [1] DEBUG: Octet string dump ends. 2010-06-17 05:50:20 [1662] [1] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:21 [1662] [2] DEBUG: SMPP[main]: Got PDU: 2010-06-17 05:50:21 [1662] [2] DEBUG: SMPP PDU 0x70a690 dump: 2010-06-17 05:50:21 [1662] [2] DEBUG: type_name: deliver_sm_resp 2010-06-17 05:50:21 [1662] [2] DEBUG: command_id: 2147483653 = 0x80000005 2010-06-17 05:50:21 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:21 [1662] [2] DEBUG: sequence_number: 1 = 0x00000001 2010-06-17 05:50:21 [1662] [2] DEBUG: message_id: NULL 2010-06-17 05:50:21 [1662] [2] DEBUG: SMPP PDU dump ends. 2010-06-17 05:50:21 [1662] [2] DEBUG: SMPP[main]: Got PDU: 2010-06-17 05:50:21 [1662] [2] DEBUG: SMPP PDU 0x70a690 dump: 2010-06-17 05:50:21 [1662] [2] DEBUG: type_name: deliver_sm_resp 2010-06-17 05:50:21 [1662] [2] DEBUG: command_id: 2147483653 = 0x80000005 2010-06-17 05:50:21 [1662] [2] DEBUG: command_status: 0 = 0x00000000 2010-06-17 05:50:21 [1662] [2] DEBUG: sequence_number: 2 = 0x00000002 2010-06-17 05:50:21 [1662] [2] DEBUG: message_id: NULL 2010-06-17 05:50:21 [1662] [2] DEBUG: SMPP PDU dump ends.