Re: DLR but could not find message or was not interested Issue
Are the messages in questions are "oversized"? We are experiencing the same issue, and had determined that the issue is connected to the message length and how kannel is handling multipart messages. When sending a concatenated MT, kannel keeps normally a reference for the first part only and ignores the other parts. If provider sends you dlrs for parts other then 1st, kannel cannot mach. Regards, Lelik. On 2020-05-11 23:30, Wan Md Arif Noor Bin. Wan Nizam wrote: Hi, Thanks for the reply, tried it and same issue. Just to note that the issue is pretty random but happening regularly. Logs : 2020-05-12 11:16:34 [SMSC:6SeriesSHT] [from:62033] [to:601] [msg:154:RM0 <#> Kod WhatsApp Anda: 664-190..Anda boleh ketik pautan ini untuk mengesahkan nombor anda: v.whatsapp.com/..Jangan kongsikan kod ini.4sgLq1p5sV6] [FID:1A7A1C61] 2020-05-12 11:22:57 [SMSC:6SeriesSHT] [from:+601] [to:62033] [msg:122:id:0444210273 sub:000 dlvrd:000 submit date:2005121116 done date:2005121122 stat:DELIVRD err:000 text:RM0 <#> Kod WhatsApp] [FID:1A7A1C61] 2020-05-12 11:22:57 [85037] [7] ERROR: SMPP[6SeriesSHT]: got DLR but could not find message or was not interested in it id<444210273> dst<601>, type<1> Best Regards. Arif Noor *From:* Gorki Alfaro *Sent:* Tuesday, May 12, 2020 11:19 AM *To:* Wan Md Arif Noor Bin. Wan Nizam *Cc:* kannel users@kannel.org *Subject:* Re: DLR but could not find message or was not interested Issue Hello Try to changing your msg-id-type = 0x01 Regards Gorki On Mon, May 11, 2020 at 9:12 PM Wan Md Arif Noor Bin. Wan Nizam mailto:md.a...@forest-interactive.com>> wrote: Hello Guys, I’ve been struggling to find what is the issue with the DLR which regularly getting error “DLR but could not find message or was not interested”. From the debug logs it looks just fine but from the access logs it becomes like those normal MO instead of DN. 38029:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP[6SeriesSHT]: Got PDU: 38030:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP PDU 0x7f087c014d70 dump: 38031:2020-05-12 05:07:42 [1640] [9] DEBUG: type_name: deliver_sm 38032:2020-05-12 05:07:42 [1640] [9] DEBUG: command_id: 5 = 0x0005 38033:2020-05-12 05:07:42 [1640] [9] DEBUG: command_status: 0 = 0x 38034:2020-05-12 05:07:42 [1640] [9] DEBUG: sequence_number: 253886944 = 0x0f2201e0 38035:2020-05-12 05:07:42 [1640] [9] DEBUG: service_type: NULL 38036:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr_ton: 1 = 0x0001 38037:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr_npi: 1 = 0x0001 38038:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr: "601" 38039:2020-05-12 05:07:42 [1640] [9] DEBUG: dest_addr_ton: 0 = 0x 38040:2020-05-12 05:07:42 [1640] [9] DEBUG: dest_addr_npi: 1 = 0x0001 38041:2020-05-12 05:07:42 [1640] [9] DEBUG: destination_addr: "63660" 38042:2020-05-12 05:07:42 [1640] [9] DEBUG: esm_class: 4 = 0x0004 38043:2020-05-12 05:07:42 [1640] [9] DEBUG: protocol_id: 0 = 0x 38044:2020-05-12 05:07:42 [1640] [9] DEBUG: priority_flag: 0 = 0x 38045:2020-05-12 05:07:42 [1640] [9] DEBUG: schedule_delivery_time: NULL 38046:2020-05-12 05:07:42 [1640] [9] DEBUG: validity_period: NULL 38047:2020-05-12 05:07:42 [1640] [9] DEBUG: registered_delivery: 0 = 0x 38048:2020-05-12 05:07:42 [1640] [9] DEBUG: replace_if_present_flag: 0 = 0x 38049:2020-05-12 05:07:42 [1640] [9] DEBUG: data_coding: 0 = 0x 38050:2020-05-12 05:07:42 [1640] [9] DEBUG: sm_default_msg_id: 0 = 0x 38051:2020-05-12 05:07:42 [1640] [9] DEBUG: sm_length: 122 = 0x007a 38052:2020-05-12 05:07:42 [1640] [9] DEBUG: short_message: 38053:2020-05-12 05:07:42 [1640] [9] DEBUG: Octet string at 0x7f087c014330: 38054:2020-05-12 05:07:42 [1640] [9] DEBUG: len: 122 38055:2020-05-12 05:07:42 [1640] [9] DEBUG: size: 123 38056:2020-05-12 05:07:42 [1640] [9] DEBUG: immutable: 0 38057:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 69 64 3a 30 34 31 36 32 39 33 38 30 38 20 73 75 id:0416293808 su 38058:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 62 3a 30 30 30 20 64 6c 76 72 64 3a 30 30 30 20 b:000 dlvrd:000 38059:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 73 75 62 6d 69 74 20 64 61 74 65 3a 32 30 30 35 submit date:2005 38060:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 31 32 30 35 30 37 20 64 6f 6e 65 20 64 61 74 65 120507 done date 38061:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 3a 32 30 30 35 31 32 30 35 30 37 20 73 74 61 74 :2005120507 stat 38062:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 3a 55 4e 44 45 4c 49 56 20 65 72 72 3a 32 34 35 :UNDELIV err:245 38063:2020-05-12 05:07:42
RE: DLR but could not find message or was not interested Issue
Hi, Thanks for the reply, tried it and same issue. Just to note that the issue is pretty random but happening regularly. Logs : 2020-05-12 11:16:34 [SMSC:6SeriesSHT] [from:62033] [to:601] [msg:154:RM0 <#> Kod WhatsApp Anda: 664-190..Anda boleh ketik pautan ini untuk mengesahkan nombor anda: v.whatsapp.com/..Jangan kongsikan kod ini.4sgLq1p5sV6] [FID:1A7A1C61] 2020-05-12 11:22:57 [SMSC:6SeriesSHT] [from:+601] [to:62033] [msg:122:id:0444210273 sub:000 dlvrd:000 submit date:2005121116 done date:2005121122 stat:DELIVRD err:000 text:RM0 <#> Kod WhatsApp] [FID:1A7A1C61] 2020-05-12 11:22:57 [85037] [7] ERROR: SMPP[6SeriesSHT]: got DLR but could not find message or was not interested in it id<444210273> dst<601>, type<1> Best Regards. Arif Noor From: Gorki Alfaro Sent: Tuesday, May 12, 2020 11:19 AM To: Wan Md Arif Noor Bin. Wan Nizam Cc: kannel users@kannel.org Subject: Re: DLR but could not find message or was not interested Issue Hello Try to changing your msg-id-type = 0x01 Regards Gorki On Mon, May 11, 2020 at 9:12 PM Wan Md Arif Noor Bin. Wan Nizam mailto:md.a...@forest-interactive.com>> wrote: Hello Guys, I’ve been struggling to find what is the issue with the DLR which regularly getting error “DLR but could not find message or was not interested”. From the debug logs it looks just fine but from the access logs it becomes like those normal MO instead of DN. 38029:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP[6SeriesSHT]: Got PDU: 38030:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP PDU 0x7f087c014d70 dump: 38031:2020-05-12 05:07:42 [1640] [9] DEBUG: type_name: deliver_sm 38032:2020-05-12 05:07:42 [1640] [9] DEBUG: command_id: 5 = 0x0005 38033:2020-05-12 05:07:42 [1640] [9] DEBUG: command_status: 0 = 0x 38034:2020-05-12 05:07:42 [1640] [9] DEBUG: sequence_number: 253886944 = 0x0f2201e0 38035:2020-05-12 05:07:42 [1640] [9] DEBUG: service_type: NULL 38036:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr_ton: 1 = 0x0001 38037:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr_npi: 1 = 0x0001 38038:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr: "601" 38039:2020-05-12 05:07:42 [1640] [9] DEBUG: dest_addr_ton: 0 = 0x 38040:2020-05-12 05:07:42 [1640] [9] DEBUG: dest_addr_npi: 1 = 0x0001 38041:2020-05-12 05:07:42 [1640] [9] DEBUG: destination_addr: "63660" 38042:2020-05-12 05:07:42 [1640] [9] DEBUG: esm_class: 4 = 0x0004 38043:2020-05-12 05:07:42 [1640] [9] DEBUG: protocol_id: 0 = 0x 38044:2020-05-12 05:07:42 [1640] [9] DEBUG: priority_flag: 0 = 0x 38045:2020-05-12 05:07:42 [1640] [9] DEBUG: schedule_delivery_time: NULL 38046:2020-05-12 05:07:42 [1640] [9] DEBUG: validity_period: NULL 38047:2020-05-12 05:07:42 [1640] [9] DEBUG: registered_delivery: 0 = 0x 38048:2020-05-12 05:07:42 [1640] [9] DEBUG: replace_if_present_flag: 0 = 0x 38049:2020-05-12 05:07:42 [1640] [9] DEBUG: data_coding: 0 = 0x 38050:2020-05-12 05:07:42 [1640] [9] DEBUG: sm_default_msg_id: 0 = 0x 38051:2020-05-12 05:07:42 [1640] [9] DEBUG: sm_length: 122 = 0x007a 38052:2020-05-12 05:07:42 [1640] [9] DEBUG: short_message: 38053:2020-05-12 05:07:42 [1640] [9] DEBUG:Octet string at 0x7f087c014330: 38054:2020-05-12 05:07:42 [1640] [9] DEBUG: len: 122 38055:2020-05-12 05:07:42 [1640] [9] DEBUG: size: 123 38056:2020-05-12 05:07:42 [1640] [9] DEBUG: immutable: 0 38057:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 69 64 3a 30 34 31 36 32 39 33 38 30 38 20 73 75 id:0416293808 su 38058:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 62 3a 30 30 30 20 64 6c 76 72 64 3a 30 30 30 20 b:000 dlvrd:000 38059:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 73 75 62 6d 69 74 20 64 61 74 65 3a 32 30 30 35 submit date:2005 38060:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 31 32 30 35 30 37 20 64 6f 6e 65 20 64 61 74 65 120507 done date 38061:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 3a 32 30 30 35 31 32 30 35 30 37 20 73 74 61 74 :2005120507 stat 38062:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 3a 55 4e 44 45 4c 49 56 20 65 72 72 3a 32 34 35 :UNDELIV err:245 38063:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 20 74 65 78 74 3a 52 4d 30 2e 30 30 20 3a 20 59text:RM0.00 : Y 38064:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 6f 75 72 20 53 68 6f 70 65 65 our Shopee 38065:2020-05-12 05:07:42 [1640] [9] DEBUG:Octet string dump ends. 38066:2020-05-12 05:07:42 [1640] [9] DEBUG: message_state: 5 = 0x0005 38067:2020-05-12 05:07:42 [1640] [9] DEBUG: receipted_message_id: "18D023B0" 38068:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP PDU dump ends. 38069:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP[6SeriesSHT] handle_pdu, got DLR 38070:2020-05-12 05:07:42 [1640] [9] DEBUG: DLR[mysql]: Looking for DLR smsc=6SeriesSHT, ts=18D023B0, dst=601, type=2 38071:2020-05-12 05:07:42 [1640] [9] DEBUG:
Re: DLR but could not find message or was not interested Issue
Hello Try to changing your msg-id-type = 0x01 Regards Gorki On Mon, May 11, 2020 at 9:12 PM Wan Md Arif Noor Bin. Wan Nizam < md.a...@forest-interactive.com> wrote: > Hello Guys, > > > > I’ve been struggling to find what is the issue with the DLR which > regularly getting error “DLR but could not find message or was not > interested”. From the debug logs it looks just fine but from the access > logs it becomes like those normal MO instead of DN. > > > > 38029:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP[6SeriesSHT]: Got PDU: > > 38030:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP PDU 0x7f087c014d70 dump: > > 38031:2020-05-12 05:07:42 [1640] [9] DEBUG: type_name: deliver_sm > > 38032:2020-05-12 05:07:42 [1640] [9] DEBUG: command_id: 5 = 0x0005 > > 38033:2020-05-12 05:07:42 [1640] [9] DEBUG: command_status: 0 = > 0x > > 38034:2020-05-12 05:07:42 [1640] [9] DEBUG: sequence_number: 253886944 = > 0x0f2201e0 > > 38035:2020-05-12 05:07:42 [1640] [9] DEBUG: service_type: NULL > > 38036:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr_ton: 1 = > 0x0001 > > 38037:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr_npi: 1 = > 0x0001 > > 38038:2020-05-12 05:07:42 [1640] [9] DEBUG: source_addr: "601" > > 38039:2020-05-12 05:07:42 [1640] [9] DEBUG: dest_addr_ton: 0 = 0x > > 38040:2020-05-12 05:07:42 [1640] [9] DEBUG: dest_addr_npi: 1 = 0x0001 > > 38041:2020-05-12 05:07:42 [1640] [9] DEBUG: destination_addr: "63660" > > 38042:2020-05-12 05:07:42 [1640] [9] DEBUG: esm_class: 4 = 0x0004 > > 38043:2020-05-12 05:07:42 [1640] [9] DEBUG: protocol_id: 0 = 0x > > 38044:2020-05-12 05:07:42 [1640] [9] DEBUG: priority_flag: 0 = 0x > > 38045:2020-05-12 05:07:42 [1640] [9] DEBUG: schedule_delivery_time: NULL > > 38046:2020-05-12 05:07:42 [1640] [9] DEBUG: validity_period: NULL > > 38047:2020-05-12 05:07:42 [1640] [9] DEBUG: registered_delivery: 0 = > 0x > > 38048:2020-05-12 05:07:42 [1640] [9] DEBUG: replace_if_present_flag: 0 = > 0x > > 38049:2020-05-12 05:07:42 [1640] [9] DEBUG: data_coding: 0 = 0x > > 38050:2020-05-12 05:07:42 [1640] [9] DEBUG: sm_default_msg_id: 0 = > 0x > > 38051:2020-05-12 05:07:42 [1640] [9] DEBUG: sm_length: 122 = 0x007a > > 38052:2020-05-12 05:07:42 [1640] [9] DEBUG: short_message: > > 38053:2020-05-12 05:07:42 [1640] [9] DEBUG:Octet string at > 0x7f087c014330: > > 38054:2020-05-12 05:07:42 [1640] [9] DEBUG: len: 122 > > 38055:2020-05-12 05:07:42 [1640] [9] DEBUG: size: 123 > > 38056:2020-05-12 05:07:42 [1640] [9] DEBUG: immutable: 0 > > 38057:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 69 64 3a 30 34 31 > 36 32 39 33 38 30 38 20 73 75 id:0416293808 su > > 38058:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 62 3a 30 30 30 20 > 64 6c 76 72 64 3a 30 30 30 20 b:000 dlvrd:000 > > 38059:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 73 75 62 6d 69 74 > 20 64 61 74 65 3a 32 30 30 35 submit date:2005 > > 38060:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 31 32 30 35 30 37 > 20 64 6f 6e 65 20 64 61 74 65 120507 done date > > 38061:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 3a 32 30 30 35 31 > 32 30 35 30 37 20 73 74 61 74 :2005120507 stat > > 38062:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 3a 55 4e 44 45 4c > 49 56 20 65 72 72 3a 32 34 35 :UNDELIV err:245 > > 38063:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 20 74 65 78 74 3a > 52 4d 30 2e 30 30 20 3a 20 59text:RM0.00 : Y > > 38064:2020-05-12 05:07:42 [1640] [9] DEBUG: data: 6f 75 72 20 53 68 > 6f 70 65 65 our Shopee > > 38065:2020-05-12 05:07:42 [1640] [9] DEBUG:Octet string dump ends. > > 38066:2020-05-12 05:07:42 [1640] [9] DEBUG: message_state: 5 = 0x0005 > > 38067:2020-05-12 05:07:42 [1640] [9] DEBUG: receipted_message_id: " > 18D023B0" > > 38068:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP PDU dump ends. > > 38069:2020-05-12 05:07:42 [1640] [9] DEBUG: SMPP[6SeriesSHT] handle_pdu, > got DLR > > 38070:2020-05-12 05:07:42 [1640] [9] DEBUG: DLR[mysql]: Looking for DLR > smsc=6SeriesSHT, ts=18D023B0, dst=601, type=2 > > 38071:2020-05-12 05:07:42 [1640] [9] DEBUG: sql: SELECT `mask`, `service`, > `url`, `source`, `destination`, `boxcid` FROM `smpp_dlr` WHERE `smsc`=? AND > `ts`=? LIMIT 1 > > 38072:2020-05-12 05:07:42 [1640] [9] DEBUG: column=mask buffer_type=3 > max_length=0 length=10 > > 38073:2020-05-12 05:07:42 [1640] [9] DEBUG: column=service buffer_type=253 > max_length=0 length=40 > > 38074:2020-05-12 05:07:42 [1640] [9] DEBUG: column=url buffer_type=253 > max_length=0 length=255 > > 38075:2020-05-12 05:07:42 [1640] [9] DEBUG: column=source buffer_type=253 > max_length=0 length=40 > > 38076:2020-05-12 05:07:42 [1640] [9] DEBUG: column=destination > buffer_type=253 max_length=0 length=40 > > 38077:2020-05-12 05:07:42 [1640] [9] DEBUG: column=boxcid buffer_type=253 > max_length=0 length=40 > > 38078:2020-05-12
