Re: Throughput problem on 1.4.2

[Christos Karaviotis]

And here is my kannel.conf =================== group = core admin-port = 13000 smsbox-port = 13001 admin-password = ********* log-file = "/var/log/kannel/bearerbox.log" access-log = "/var/log/kannel/access.log" sms-incoming-queue-limit = -1 sms-resend-freq = 2 box-deny-ip = "*.*.*.*" box-allow-ip = "127.0.0.1;192.168.1.110;192.168.1.5;82.***.***.***" group = smsbox bearerbox-host = 127.0.0.1 sendsms-port = 13013 mo-recode = 1 log-file = "/var/log/kannel/smsbox.log" log-level = 0 group = smsc smsc = smpp smsc-id = SomeT host = 213.***.***.*** port = 6200 log-file = "/var/log/kannel/smscmtn.log" log-level = 0 bind-addr-ton = 1 bind-addr-npi = 1 source-addr-ton = 5 source-addr-npi = 0 dest-addr-ton = 1 dest-addr-npi = 1 smsc-username = "*****" smsc-password = ******* system-type = "kannel" denied-prefix = "00" preferred-prefix = "+357;357" allowed-prefix = "+357;357" throughput = 2 wait-ack = 5 wait-ack-expire = 2 max-pending-submits = 100 address-range = "***.***.***.***" group = modems id = W880i name = "Sony Ericsson Mobile Communications AB" init-string = "ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0" #keepalive-cmd = "AT+CBC;+CSQ;+CMGF=0" detect-string = "Sony Ericsson W880" group = modems id = W960i name = "Sony Ericsson Mobile Communications AB" init-string = "ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0" detect-string = "Sony Ericsson W960i" group = smsc smsc = at smsc-id = W880i log-file = "/var/log/kannel/smscw880i.log" log-level = 0 modemtype = auto device=/dev/ttyACM1 my-number = +35********** connect-allow-ip = 127.0.0.1 denied-prefix = "+357;357;99;96;97" preferred-prefix = "00;+" allowed-prefix = "00;+" log-level = 3 group = smsc smsc = at smsc-id = W960i log-file = "/var/log/kannel/smscw960i.log" log-level = 0 modemtype = auto device=/dev/ttyACM3 my-number = +35********** connect-allow-ip = 127.0.0.1 denied-prefix = "+357;357;99;96;97" preferred-prefix = "00;+" allowed-prefix = "00;+" log-level = 3 group = sendsms-user username = kanneluser password = *********** concatenation = true max-messages = 10 group = sms-service keyword = #keyword-regex = catch-all = yes max-messages = 10 get-url = "" class="moz-txt-link-rfc2396E" href="http://localhost/sms?phone=%p&text=%a">"http://localhost/sms?phone=%p&text=%a" ================================== Christos Karaviotis wrote: I have fresh logs and I am attaching them Nikos Balkanas wrote: Well, if i remember correctly, bearerbox router wakes up every 30" and resends the queue. That's where your delay is coming from.Β  Β  So,Β if I understand you correctly, when you try to send 3 messages simultaneously, bearerbox will forgo of throughput settings and try to send all messages through at once, which results inΒ 1 message getting bounced and resent with a 30" delay. Am I right? Β  Unfortunately, you cat your bearerbox log too soon, and couldn't see any messages other than the first been sent. Β  Β  You should definitely wait more than 1 sec for ack. Try 5. Also set wait-ack-expire to 2 (wait and send nothing until ack). In such a scenario you should use the default value for max-pending-submits, i.e. 10. Β  Could you give it another run with bearerbox from the shell -D 0 and -v 0? Make sure that you get all messages in the logs. Β  BR, Nikos ----- Original Message ----- From: Christos Karaviotis To: Nikos Balkanas Cc: Ishtiaq Ahmed ; users@kannel.org Sent: Tuesday, February 03, 2009 3:15 AM Subject: Re: Throughput problem on 1.4.2 Thank you for taking the time on this log.Β Β  From what I understand there was a good 30 seconds before the 3rd message was send. 2 messages per second without the 30 seconds delay between the next 2 due to the 'Throttling error' which I believe it is because kannel is trying to send more than 2 each time and the providers limitations do not accept that.Β  In essence I want to get rid of that delay. 2 messages per second constantly or with a minor delay. Thank you again for taking the time for this Chris Nikos Balkanas wrote: Hi, Β  Your bearerbox logs seem fine. They say that smsbox sent 3 SMS @ 17:59:40 and finally 1 messageΒ is send to the SMSc @ 17:59:42. I don't see in the logs any other messages been sent. Isn't that what you wanted? Β  BR, NikosΒ  ----- Original Message ----- From: Christos Karaviotis To: Ishtiaq Ahmed Cc: users@kannel.org Sent: Monday, February 02, 2009 6:27 PM Subject: Re: Throughput problem on 1.4.2 Also on the bearerbox log I have the following ============================= 2009-02-02 17:59:40 [12135] [10] DEBUG: boxc_receiver: sms received 2009-02-02 17:59:40 [12135] [10] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2009-02-02 17:59:40 [12135] [10] DEBUG: boxc_receiver: sms received 2009-02-02 17:59:40 [12135] [10] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2009-02-02 17:59:40 [12135] [10] DEBUG: boxc_receiver: sms received 2009-02-02 17:59:40 [12135] [10] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2009-02-02 17:59:40 [12135] [9] DEBUG: sms_router: handling message (0x87c0d08 vs 0x87c0d08) 2009-02-02 17:59:40 [12135] [9] DEBUG: re-queing SMS not-yet-to-be resent 2009-02-02 17:59:40 [12135] [9] DEBUG: sms_router: handling message (0x87c0d08 vs 0x87c0d08) 2009-02-02 17:59:40 [12135] [9] DEBUG: re-queing SMS not-yet-to-be resent 2009-02-02 17:59:40 [12135] [9] DEBUG: sms_router: time to sleep 2.00 secs. 2009-02-02 17:59:40 [12135] [9] DEBUG: sms_router: gwlist_len = 1 2009-02-02 17:59:40 [12135] [9] DEBUG: sms_router: handling message (0x87c0d08 vs 0x87c0d08) 2009-02-02 17:59:40 [12135] [9] DEBUG: re-queing SMS not-yet-to-be resent 2009-02-02 17:59:40 [12135] [9] DEBUG: sms_router: handling message (0x87c0d08 vs 0x87c0d08) 2009-02-02 17:59:40 [12135] [9] DEBUG: re-queing SMS not-yet-to-be resent 2009-02-02 17:59:40 [12135] [9] DEBUG: sms_router: time to sleep 2.00 secs. 2009-02-02 17:59:42 [12135] [9] DEBUG: sms_router: gwlist_len = 1 2009-02-02 17:59:42 [12135] [9] DEBUG: sms_router: handling message (0x87c0d08 vs 0x87c0d08) 2009-02-02 17:59:42 [12135] [9] DEBUG: Message routed successfully. ============================== Sorry for the delay I tried that but no luck. ============================================ Here is the debug log when I try to send to 3 numbers at the same time. -------------------------------------------------------------------------------------------------------------- 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Manually forced source addr ton = 5, source add npi = 0 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Manually forced dest addr ton = 1, dest add npi = 1 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Sending PDU: 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 4 = 0x00000004 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 11 = 0x0000000b 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  service_type: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_ton: 5 = 0x00000005 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_npi: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr: "SomeT" 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_ton: 1 = 0x00000001 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_npi: 1 = 0x00000001 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  destination_addr: "35*******" 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  esm_class: 3 = 0x00000003 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  protocol_id: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  priority_flag: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  schedule_delivery_time: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  validity_period: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  registered_delivery: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  replace_if_present_flag: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  data_coding: 8 = 0x00000008 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_default_msg_id: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_length: 18 = 0x00000012 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  short_message: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string at 0xb4102730: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  len:Ξ’Β  18 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  size: 19 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  immutable: 0 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 72 00 65 00 73 00 74 00 20 00 6f 00 66 00 20Ξ’Β Ξ’Β  .r.e.s.t. .o.f. 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 35Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  .5 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string dump ends. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Manually forced source addr ton = 5, source add npi = 0 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Manually forced dest addr ton = 1, dest add npi = 1 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Sending PDU: 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 4 = 0x00000004 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 12 = 0x0000000c 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  service_type: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_ton: 5 = 0x00000005 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_npi: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr: "XMASITS" 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_ton: 1 = 0x00000001 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_npi: 1 = 0x00000001 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  destination_addr: "35*********" 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  esm_class: 3 = 0x00000003 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  protocol_id: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  priority_flag: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  schedule_delivery_time: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  validity_period: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  registered_delivery: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  replace_if_present_flag: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  data_coding: 8 = 0x00000008 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_default_msg_id: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_length: 18 = 0x00000012 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  short_message: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string at 0xb4102730: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  len:Ξ’Β  18 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  size: 19 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  immutable: 0 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 72 00 65 00 73 00 74 00 20 00 6f 00 66 00 20Ξ’Β Ξ’Β  .r.e.s.t. .o.f. 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 35Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  .5 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string dump ends. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Manually forced source addr ton = 5, source add npi = 0 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Manually forced dest addr ton = 1, dest add npi = 1 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Sending PDU: 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 4 = 0x00000004 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 13 = 0x0000000d 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  service_type: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_ton: 5 = 0x00000005 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_npi: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr: "someT" 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_ton: 1 = 0x00000001 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_npi: 1 = 0x00000001 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  destination_addr: "35********" 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  esm_class: 3 = 0x00000003 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  protocol_id: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  priority_flag: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  schedule_delivery_time: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  validity_period: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  registered_delivery: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  replace_if_present_flag: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  data_coding: 8 = 0x00000008 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_default_msg_id: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_length: 18 = 0x00000012 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  short_message: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string at 0xb4102730: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  len:Ξ’Β  18 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  size: 19 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  immutable: 0 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 72 00 65 00 73 00 74 00 20 00 6f 00 66 00 20Ξ’Β Ξ’Β  .r.e.s.t. .o.f. 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 35Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  .5 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string dump ends. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Got PDU: 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm_resp 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 2147483652 = 0x80000004 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 11 = 0x0000000b 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  message_id: "4" 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Got PDU: 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm_resp 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 2147483652 = 0x80000004 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 12 = 0x0000000c 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  message_id: "5" 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 17:59:40 [12135] [6] WARNING: SMPP: PDU NULL terminated string (message_id) has no NULL. 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP[MTN]: Got PDU: 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm_resp 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 2147483652 = 0x80000004 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 88 = 0x00000058 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 13 = 0x0000000d 2009-02-02 17:59:40 [12135] [6] DEBUG:Ξ’Β Ξ’Β  message_id: NULL 2009-02-02 17:59:40 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 17:59:40 [12135] [6] ERROR: SMPP[MTN]: SMSC returned error code 0x00000058 (Throttling error) in response to submit_sm. 2009-02-02 17:59:44 [12135] [6] DEBUG: SMPP[MTN]: Sending enquire link: 2009-02-02 17:59:44 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: enquire_link 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 21 = 0x00000015 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 14 = 0x0000000e 2009-02-02 17:59:44 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 17:59:44 [12135] [6] DEBUG: SMPP[MTN]: Got PDU: 2009-02-02 17:59:44 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: enquire_link_resp 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 2147483669 = 0x80000015 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 17:59:44 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 14 = 0x0000000e 2009-02-02 17:59:44 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP[MTN]: Sending enquire link: 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: enquire_link 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 21 = 0x00000015 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 15 = 0x0000000f 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP[MTN]: Manually forced source addr ton = 5, source add npi = 0 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP[MTN]: Manually forced dest addr ton = 1, dest add npi = 1 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP[MTN]: Sending PDU: 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 4 = 0x00000004 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 16 = 0x00000010 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  service_type: NULL 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_ton: 5 = 0x00000005 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr_npi: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  source_addr: "SomeT" 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_ton: 1 = 0x00000001 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  dest_addr_npi: 1 = 0x00000001 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  destination_addr: "35********" 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  esm_class: 3 = 0x00000003 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  protocol_id: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  priority_flag: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  schedule_delivery_time: NULL 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  validity_period: NULL 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  registered_delivery: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  replace_if_present_flag: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  data_coding: 8 = 0x00000008 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_default_msg_id: 0 = 0x00000000 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sm_length: 18 = 0x00000012 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β  short_message: 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string at 0xb4102740: 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  len:Ξ’Β  18 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  size: 19 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  immutable: 0 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 72 00 65 00 73 00 74 00 20 00 6f 00 66 00 20Ξ’Β Ξ’Β  .r.e.s.t. .o.f. 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  data: 00 35Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β Ξ’Β  .5 2009-02-02 18:00:14 [12135] [6] DEBUG:Ξ’Β Ξ’Β Ξ’Β  Octet string dump ends. 2009-02-02 18:00:14 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 18:00:15 [12135] [6] DEBUG: SMPP[MTN]: Got PDU: 2009-02-02 18:00:15 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: enquire_link_resp 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 2147483669 = 0x80000015 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 15 = 0x0000000f 2009-02-02 18:00:15 [12135] [6] DEBUG: SMPP PDU dump ends. 2009-02-02 18:00:15 [12135] [6] DEBUG: SMPP[MTN]: Got PDU: 2009-02-02 18:00:15 [12135] [6] DEBUG: SMPP PDU 0xb4102658 dump: 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  type_name: submit_sm_resp 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_id: 2147483652 = 0x80000004 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  command_status: 0 = 0x00000000 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  sequence_number: 16 = 0x00000010 2009-02-02 18:00:15 [12135] [6] DEBUG:Ξ’Β Ξ’Β  message_id: "6" 2009-02-02 18:00:15 [12135] [6] DEBUG: SMPP PDU dump ends. ================================================================ Thank you Chris Ishtiaq Ahmed wrote: Hi Chris, It would be better if you can attach some debug log with it... But In my opinion you should try the bigger value for wait-ack.... something like throughput = 2 wait-ack = 600 Regards, Ishtiaq Ahmed Christos Karaviotis wrote: Hi people, I know that this must have been asked dozen of times.Ξ’Β  I have checked the last 2 years archives but found nothing. OK here is my problem, I have upgraded Kannel from 1.4.1 to 1.4.2 and now I have the need due to 'throughput error' to limit the messages per second that Kannel sends to the SMPP.Ξ’Β  Our provider limits us to 2 m/sec.Ξ’Β  I have added under the specific SMSC configuration the 'throughput = 2' but no luck.Ξ’Β  Kannel still tries to send the entire queue at once. _Here is the configuration _ group = smsc smsc = smpp smsc-id = A host = 213.***.***.*** port = 6200 bind-addr-ton = 1 bind-addr-npi = 1 source-addr-ton = 5 source-addr-npi = 0 dest-addr-ton = 1 dest-addr-npi = 1 smsc-username = "*******" smsc-password = ******* system-type = "kannel" throughput = 2 wait-ack = 1 max-pending-submits = 1 address-range = "91.***.***.***" Did I have to compile Kannel with some special parameters or did I have to do something and I did not do? Thank you Chris