Hi, this was a typo in my patch. Fixed in SVN.
Alex Am 25.02.2013 um 17:21 schrieb Alexander Malysh <[email protected]>: > Hmm very strange UDH, I will look into this. > > Alex > > Am 25.02.2013 um 10:41 schrieb [Digital^Dude] ® <[email protected]>: > >> Yes, I use SMPP SMSC. >> bearerbox log: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP[xxxxx]: throughput (0.00,1.00) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter tag (0x000e) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter length read as 1 >> 2013-02-25 14:04:51 [3768] [6] WARNING: SMPP: Unknown TLV(0x000e,0x0001,01) >> for PDU type (deliver_sm) received! >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter tag (0x0006) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter length read as 1 >> 2013-02-25 14:04:51 [3768] [6] WARNING: SMPP: Unknown TLV(0x0006,0x0001,01) >> for PDU type (deliver_sm) received! >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter tag (0x020c) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter length read as 2 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter tag (0x020e) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter length read as 1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter tag (0x020f) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter length read as 1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter tag (0x0424) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Optional parameter length read as 27 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP[xxxxx]: Got PDU: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP PDU 0x8dc3190 dump: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: type_name: deliver_sm >> 2013-02-25 14:04:51 [3768] [6] DEBUG: command_id: 5 = 0x00000005 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: command_status: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sequence_number: 3 = 0x00000003 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: service_type: NULL >> 2013-02-25 14:04:51 [3768] [6] DEBUG: source_addr_ton: 1 = 0x00000001 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: source_addr_npi: 1 = 0x00000001 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: source_addr: "923029422885" >> 2013-02-25 14:04:51 [3768] [6] DEBUG: dest_addr_ton: 4 = 0x00000004 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: dest_addr_npi: 1 = 0x00000001 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: destination_addr: "1767" >> 2013-02-25 14:04:51 [3768] [6] DEBUG: esm_class: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: protocol_id: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: priority_flag: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: schedule_delivery_time: NULL >> 2013-02-25 14:04:51 [3768] [6] DEBUG: validity_period: NULL >> 2013-02-25 14:04:51 [3768] [6] DEBUG: registered_delivery: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: replace_if_present_flag: 0 = >> 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data_coding: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sm_default_msg_id: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sm_length: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: short_message: "" >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sar_msg_ref_num: 87 = 0x00000057 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sar_total_segments: 2 = 0x00000002 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sar_segment_seqnum: 2 = 0x00000002 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: message_payload: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dc4478: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 27 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 28 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: 78 20 6a 75 6d 70 73 20 6f >> 76 65 72 20 74 68 65 x jumps over the >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: 20 6c 61 7a 79 20 64 6f 67 >> 2e 20 lazy dog. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP PDU dump ends. >> 2013-02-25 14:04:51 [3768] [6] ERROR: Failed to convert string from <gsm> to >> <UTF-8> - probably broken type names. >> 2013-02-25 14:04:51 [3768] [6] ERROR: Failed to convert msgdata from charset >> <gsm> to <UTF-8>, will leave as is. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Got part 255 [ref 2, total parts 255] >> of message from xxxxx. Dump follows: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Msg object at 0x8dcf538: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: type: sms >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.sender: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dcf608: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 13 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 14 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: xxxxx xxxxx >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.receiver: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dcf638: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 4 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 5 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: xxxxxxxx >> xxxxxxxx >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.udhdata: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dcf650: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 6 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 7 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: 05 00 03 02 ff ff >> ...... >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.msgdata: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dcf678: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 27 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 28 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: 78 20 6a 75 6d 70 73 20 6f 76 >> 65 72 20 74 68 65 x jumps over the >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: 20 6c 61 7a 79 20 64 6f 67 2e >> 20 lazy dog. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.time: 1361783091 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.smsc_id: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dcf690: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 7 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 8 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: 4c 41 5f 31 37 36 37 >> xxxxx >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.smsc_number: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.foreign_id: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.service: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.account: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dcf6b8: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 5 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 6 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: xxxxxxxxxxxxx >> xxxxx >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.id: >> 864f6df5-3944-4d67-bcf1-b8d31162ed06 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.sms_type: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.mclass: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.mwi: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.coding: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.compress: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.validity: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.deferred: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.dlr_mask: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.dlr_url: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.pid: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.alt_dcs: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.rpi: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.charset: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.boxc_id: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.binfo: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.msg_left: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.split_parts: (nil) >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.priority: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.resend_try: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.resend_time: -1 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sms.meta_data: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string at 0x8dcf6e0: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: len: 6 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: size: 7 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: immutable: 0 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: data: 3f 73 6d 70 70 3f >> ?smpp? >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Octet string dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: Msg object ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP[xxxxx]: Sending PDU: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP PDU 0x8dc32a8 dump: >> 2013-02-25 14:04:51 [3768] [6] DEBUG: type_name: deliver_sm_resp >> 2013-02-25 14:04:51 [3768] [6] DEBUG: command_id: 2147483653 = 0x80000005 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: command_status: 0 = 0x00000000 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: sequence_number: 3 = 0x00000003 >> 2013-02-25 14:04:51 [3768] [6] DEBUG: message_id: NULL >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP PDU dump ends. >> 2013-02-25 14:04:51 [3768] [6] DEBUG: SMPP[xxxxx]: throughput (0.00,1.00) >> 2013-02-25 14:04:54 [3768] [3] DEBUG: HTTP: Resetting HTTPClient for `xxxxx'. >> 2013-02-25 14:04:55 [3768] [3] DEBUG: HTTP: Resetting HTTPClient for `xxxxx'. >> >> >> SMSBOX: >> 2013-02-25 13:55:44 [3776] [0] INFO: Starting to log to file >> /var/log/kannel/smsbox.log level 0 >> 2013-02-25 13:55:44 [3776] [0] INFO: Added logfile >> `/var/log/kannel/smsbox.log' with level `0'. >> 2013-02-25 13:55:44 [3776] [0] INFO: Service global sender set as '13013' >> 2013-02-25 13:55:44 [3776] [0] INFO: HTTP: Opening server at port 13013. >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller) >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Started thread 2 >> (gwlib/http.c:server_thread) >> 2013-02-25 13:55:44 [3776] [0] INFO: Set up send sms service at port 13013 >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Started thread 3 >> (gw/smsbox.c:sendsms_thread) >> 2013-02-25 13:55:44 [3776] [0] DEBUG: >> ---------------------------------------------- >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Kannel smsbox version svn-r5024M >> starting >> 2013-02-25 13:55:44 [3776] [0] DEBUG: dumping group (sendsms-user): >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <group> = <sendsms-user> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <user-deny-ip> = <*.*.*.*> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <forced-smsc> = <xxxxxx> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <password> = <abc> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <max-messages> = <20> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <username> = <test> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <concatenation> = <true> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: <user-allow-ip> = <127.0.0.1> >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Started thread 4 >> (gw/smsbox.c:obey_request_thread) >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Started thread 5 >> (gw/smsbox.c:url_result_thread) >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Started thread 6 >> (gw/smsbox.c:http_queue_thread) >> 2013-02-25 13:55:44 [3776] [3] DEBUG: Thread 3 (gw/smsbox.c:sendsms_thread) >> maps to pid 3776. >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Connecting to <127.0.0.1> >> 2013-02-25 13:55:44 [3776] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) >> maps to pid 3776. >> 2013-02-25 13:55:44 [3776] [2] DEBUG: HTTP: Including port 13013, fd 9 for >> polling in server thread >> 2013-02-25 13:55:44 [3776] [0] INFO: Connected to bearerbox at 127.0.0.1 >> port 13001. >> 2013-02-25 13:55:44 [3776] [0] DEBUG: Started thread 7 >> (gw/heartbeat.c:heartbeat_thread) >> 2013-02-25 13:55:44 [3776] [6] DEBUG: Thread 6 >> (gw/smsbox.c:http_queue_thread) maps to pid 3776. >> 2013-02-25 13:55:44 [3776] [5] DEBUG: Thread 5 >> (gw/smsbox.c:url_result_thread) maps to pid 3776. >> 2013-02-25 13:55:44 [3776] [4] DEBUG: Thread 4 >> (gw/smsbox.c:obey_request_thread) maps to pid 3776. >> 2013-02-25 13:55:44 [3776] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps >> to pid 3776. >> 2013-02-25 13:55:44 [3776] [7] DEBUG: Thread 7 >> (gw/heartbeat.c:heartbeat_thread) maps to pid 3776. >> 2013-02-25 13:56:10 [3776] [2] DEBUG: HTTP: Creating HTTPClient for >> `127.0.0.1'. >> 2013-02-25 13:56:10 [3776] [2] DEBUG: HTTP: Created HTTPClient area >> 0x90f9340. >> 2013-02-25 13:56:10 [3776] [3] INFO: smsbox: Got HTTP request >> </cgi-bin/sendsms> from <127.0.0.1> >> 2013-02-25 13:56:10 [3776] [3] INFO: sendsms used by <test> >> 2013-02-25 13:56:10 [3776] [3] INFO: sendsms sender:<test:FrfNOC> >> (127.0.0.1) to:<xxxxxxxxxxxxx> msg:<nop> >> 2013-02-25 13:56:10 [3776] [3] DEBUG: Stored UUID >> eef26f83-7f30-43e7-8c4b-e45b8057451f >> 2013-02-25 13:56:10 [3776] [3] DEBUG: message length 3, sending 1 messages >> 2013-02-25 13:56:10 [3776] [3] DEBUG: Status: 202 Answer: <Sent.> >> 2013-02-25 13:56:10 [3776] [3] DEBUG: Delayed reply - wait for bearerbox >> 2013-02-25 13:56:10 [3776] [0] DEBUG: Got ACK (0) of >> eef26f83-7f30-43e7-8c4b-e45b8057451f >> 2013-02-25 13:56:10 [3776] [0] DEBUG: HTTP: Destroying HTTPClient area >> 0x90f9340. >> 2013-02-25 13:56:10 [3776] [0] DEBUG: HTTP: Destroying HTTPClient for >> `127.0.0.1'. >> >> >> >> On Mon, Feb 25, 2013 at 2:12 PM, Alexander Malysh <[email protected]> wrote: >> Hi, >> >> do you use SMPP SMSC? Could you please provide bearerbox & smsbox debug log? >> >> Alex >> >> Am 25.02.2013 um 07:51 schrieb [Digital^Dude] ® <[email protected]>: >> >>> Hello, >>> >>> Since I have upgraded from r5014, I am unable to receive any hit for >>> inbound sms in my bearerbox. Kannel status does show the correct number of >>> sms received, but I cannot see the message details in any log. And hence, I >>> am unable to send an automated reply on incoming messages. Debug mode >>> logging of sms also does not facilitate. >>> >>> OS: >>> Ubuntu 11.04 natty >>> Kannel: >>> URL: https://svn.kannel.org/gateway/trunk >>> Repository Root: https://svn.kannel.org/gateway >>> Repository UUID: a7d65f57-29cd-40c9-b71e-ebca51ad1b1d >>> Revision: 5024 >>> Node Kind: directory >>> Schedule: normal >>> Last Changed Author: amalysh >>> Last Changed Rev: 5024 >>> Last Changed Date: 2013-02-21 22:01:03 +0500 (Thu, 21 Feb 2013) >>> gw/smskannel.conf: >>> group = sms-service >>> keyword = default >>> text = "No service specified" >>> alt-charset=gsm >>> forced-smsc=XXXXX >>> concatenation=true >>> catch-all=true >>> >>> I also have the following in my core: >>> sms-combine-concatenated-mo = true >>> sms-combine-concatenated-mo-timeout = "1800" >>> >>> >>> I have to use the latest version (r5024+) in order to use MO concatenation >>> feature comitted by amalysh: >>> 2013-02-21 Alexander Malysh <amalysh at kannel.org> >>> * gw/smsc/smsc_smpp.c: added support for sar_ multipart TLVs. >>> >>> Please help me get to the issue so that it can be resolved. >>> Thanks >> >> >
