Hello Nikos, Benaiad, Please find the attached bb log.
Thanks Anas Al-Naffar -----Original Message----- From: Nikos Balkanas [mailto:nbalka...@gmail.com] Sent: Wednesday, October 20, 2010 10:09 AM To: Anas Alnaffar; 'Benaiad' Cc: users@kannel.org Subject: Re: got DLR but could not find message Hi, Please post debug bb logs that contain the submit_sm & submit_sm_resp PDUs and the deliver_sm for the same SMS. BR, Nikos ----- Original Message ----- From: Anas Alnaffar To: 'Benaiad' Cc: users@kannel.org Sent: Wednesday, October 20, 2010 9:50 AM Subject: RE: got DLR but could not find message Hello Benaiad; Thanks, Please note there type1 and type 2 for same dst, but different id, please find sample below. 2010-10-09 16:53:56 [25076] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<8C2A525D> dst<999999999999>, type<2> 2010-10-09 17:21:22 [25076] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<8C3F8C7E> dst<999999999999>, type<2> 2010-10-09 18:51:17 [4307] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<904917A8> dst<999999999999>, type<1> 2010-10-09 18:51:22 [4307] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<8C5B64C8> dst<999999999999>, type<2> 2010-10-09 20:03:17 [4307] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<914B0811> dst<999999999999>, type<1> 2010-10-09 20:03:34 [4307] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<91510B86> dst<999999999999>, type<1> 2010-10-09 20:03:50 [4307] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<915C657D> dst<999999999999>, type<1> Thanks Anas Al-Naffar From: Benaiad [mailto:bena...@gmail.com] Sent: Tuesday, October 19, 2010 7:26 PM To: Anas Alnaffar Cc: users@kannel.org Subject: Re: got DLR but could not find message Hi Anas, Do you see another log entry for the same id and dst values but with type 1? Regards -- Abdulmnem Benaiad Almontaha CTO Tripoli-Libyan www.almontaha.ly about.me On Tue, Oct 19, 2010 at 4:42 PM, Anas Alnaffar <a.alnaf...@tijaritelecom.com> wrote: Dears I am having a problems with DLR, Please go through the following log: 2010-10-09 16:53:56 [25076] [6] ERROR: SMPP[zain_MT1_smpp]: got DLR but could not find message or was not interested in it id<8C2A525D> dst<*******>, type<2> Anas
2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP[MT1_smpp]: Manually forced source addr ton = 5, source add npi = 1 2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP[MT1_smpp]: Manually forced dest addr ton = 1, dest add npi = 1 2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP[MT1_smpp]: Sending PDU: 2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP PDU 0x8797fd8 dump: 2010-10-09 16:47:22 [25076] [6] DEBUG: type_name: submit_sm 2010-10-09 16:47:22 [25076] [6] DEBUG: command_id: 4 = 0x00000004 2010-10-09 16:47:22 [25076] [6] DEBUG: command_status: 0 = 0x00000000 2010-10-09 16:47:22 [25076] [6] DEBUG: sequence_number: 21488 = 0x000053f0 2010-10-09 16:47:22 [25076] [6] DEBUG: service_type: NULL 2010-10-09 16:47:22 [25076] [6] DEBUG: source_addr_ton: 5 = 0x00000005 2010-10-09 16:47:22 [25076] [6] DEBUG: source_addr_npi: 1 = 0x00000001 2010-10-09 16:47:22 [25076] [6] DEBUG: source_addr: "99999" 2010-10-09 16:47:22 [25076] [6] DEBUG: dest_addr_ton: 1 = 0x00000001 2010-10-09 16:47:22 [25076] [6] DEBUG: dest_addr_npi: 1 = 0x00000001 2010-10-09 16:47:22 [25076] [6] DEBUG: destination_addr: "999999999999" 2010-10-09 16:47:22 [25076] [6] DEBUG: esm_class: 3 = 0x00000003 2010-10-09 16:47:22 [25076] [6] DEBUG: protocol_id: 0 = 0x00000000 2010-10-09 16:47:22 [25076] [6] DEBUG: priority_flag: 0 = 0x00000000 2010-10-09 16:47:22 [25076] [6] DEBUG: schedule_delivery_time: NULL 2010-10-09 16:47:22 [25076] [6] DEBUG: validity_period: NULL 2010-10-09 16:47:22 [25076] [6] DEBUG: registered_delivery: 1 = 0x00000001 2010-10-09 16:47:22 [25076] [6] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-10-09 16:47:22 [25076] [6] DEBUG: data_coding: 8 = 0x00000008 2010-10-09 16:47:22 [25076] [6] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-10-09 16:47:22 [25076] [6] DEBUG: sm_length: 122 = 0x0000007a 2010-10-09 16:47:22 [25076] [6] DEBUG: short_message: 2010-10-09 16:47:22 [25076] [6] DEBUG: Octet string at 0x875c400: 2010-10-09 16:47:22 [25076] [6] DEBUG: len: 122 2010-10-09 16:47:22 [25076] [6] DEBUG: size: 123 2010-10-09 16:47:22 [25076] [6] DEBUG: immutable: 0 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 39 06 32 06 4a 06 32 06 46 06 27 00 20 06 27 .9.2.J.2.F.'. .' 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 44 06 39 06 45 06 4a 06 44 00 20 06 27 06 46 .D.9.E.J.D. .'.F 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 2a 00 20 06 45 06 34 06 2a 06 31 06 43 00 20 .*. .E.4.*.1.C. 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 41 06 4a 00 20 06 2e 06 2f 06 45 06 29 00 20 .A.J. .../.E.). 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 2f 06 39 06 27 06 21 00 20 06 44 06 27 00 20 ./.9.'.!. .D.'. 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 4a 06 31 06 2f 00 0a 06 46 06 34 06 43 06 31 .J.1./...F.4.C.1 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 43 00 20 06 39 06 44 06 49 00 20 06 45 06 34 .C. .9.D.I. .E.4 2010-10-09 16:47:22 [25076] [6] DEBUG: data: 06 27 06 31 06 43 06 2a 06 43 .'.1.C.*.C 2010-10-09 16:47:22 [25076] [6] DEBUG: Octet string dump ends. 2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP PDU dump ends. 2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP[MT1_smpp]: Got PDU: 2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP PDU 0x8797fd8 dump: 2010-10-09 16:47:22 [25076] [6] DEBUG: type_name: submit_sm_resp 2010-10-09 16:47:22 [25076] [6] DEBUG: command_id: 2147483652 = 0x80000004 2010-10-09 16:47:22 [25076] [6] DEBUG: command_status: 0 = 0x00000000 2010-10-09 16:47:22 [25076] [6] DEBUG: sequence_number: 21488 = 0x000053f0 2010-10-09 16:47:22 [25076] [6] DEBUG: message_id: "914B0811" 2010-10-09 16:47:22 [25076] [6] DEBUG: SMPP PDU dump ends. 2010-10-09 16:47:22 [25076] [6] DEBUG: DLR[internal]: Adding DLR smsc=MT1_smpp, ts=914B0811, src=99999, dst=999999999999, mask=7, boxc=MT1_smsbox 2010-10-09 20:03:17 [4307] [6] DEBUG: SMPP[MT1_smpp]: Got PDU: 2010-10-09 20:03:17 [4307] [6] DEBUG: SMPP PDU 0xb1a0e580 dump: 2010-10-09 20:03:17 [4307] [6] DEBUG: type_name: deliver_sm 2010-10-09 20:03:17 [4307] [6] DEBUG: command_id: 5 = 0x00000005 2010-10-09 20:03:17 [4307] [6] DEBUG: command_status: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: sequence_number: 20452 = 0x00004fe4 2010-10-09 20:03:17 [4307] [6] DEBUG: service_type: NULL 2010-10-09 20:03:17 [4307] [6] DEBUG: source_addr_ton: 1 = 0x00000001 2010-10-09 20:03:17 [4307] [6] DEBUG: source_addr_npi: 1 = 0x00000001 2010-10-09 20:03:17 [4307] [6] DEBUG: source_addr: "999999999999" 2010-10-09 20:03:17 [4307] [6] DEBUG: dest_addr_ton: 5 = 0x00000005 2010-10-09 20:03:17 [4307] [6] DEBUG: dest_addr_npi: 1 = 0x00000001 2010-10-09 20:03:17 [4307] [6] DEBUG: destination_addr: "99999" 2010-10-09 20:03:17 [4307] [6] DEBUG: esm_class: 4 = 0x00000004 2010-10-09 20:03:17 [4307] [6] DEBUG: protocol_id: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: priority_flag: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: schedule_delivery_time: NULL 2010-10-09 20:03:17 [4307] [6] DEBUG: validity_period: NULL 2010-10-09 20:03:17 [4307] [6] DEBUG: registered_delivery: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: data_coding: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: sm_length: 120 = 0x00000078 2010-10-09 20:03:17 [4307] [6] DEBUG: short_message: 2010-10-09 20:03:17 [4307] [6] DEBUG: Octet string at 0xb1a0e698: 2010-10-09 20:03:17 [4307] [6] DEBUG: len: 120 2010-10-09 20:03:17 [4307] [6] DEBUG: size: 121 2010-10-09 20:03:17 [4307] [6] DEBUG: immutable: 0 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 69 64 3a 39 31 34 42 30 38 31 31 20 73 75 62 3a id:914B0811 sub: 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 30 30 31 20 64 6c 76 72 64 3a 30 30 31 20 73 75 001 dlvrd:001 su 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 62 6d 69 74 20 64 61 74 65 3a 31 30 31 30 30 39 bmit date:101009 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 31 37 31 36 20 64 6f 6e 65 20 64 61 74 65 3a 31 1716 done date:1 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 30 31 30 30 39 31 37 31 36 20 73 74 61 74 3a 44 010091716 stat:D 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 45 4c 49 56 52 44 20 65 72 72 3a 32 35 35 20 74 ELIVRD err:255 t 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 65 78 74 3a 20 20 20 20 20 20 20 20 20 20 20 20 ext: 2010-10-09 20:03:17 [4307] [6] DEBUG: data: 20 20 20 20 20 20 20 20 2010-10-09 20:03:17 [4307] [6] DEBUG: Octet string dump ends. 2010-10-09 20:03:17 [4307] [6] DEBUG: SMPP PDU dump ends. 2010-10-09 20:03:17 [4307] [6] DEBUG: SMPP[MT1_smpp] handle_pdu, got DLR 2010-10-09 20:03:17 [4307] [6] DEBUG: DLR[internal]: Looking for DLR smsc=MT1_smpp, ts=914B0811, dst=999999999999, type=1 2010-10-09 20:03:17 [4307] [6] WARNING: DLR[internal]: DLR from SMSC<MT1_smpp> for DST<999999999999> not found. 2010-10-09 20:03:17 [4307] [6] ERROR: SMPP[MT1_smpp]: got DLR but could not find message or was not interested in it id<914B0811> dst<999999999999>, type<1> 2010-10-09 20:03:17 [4307] [6] DEBUG: SMPP[MT1_smpp]: Sending PDU: 2010-10-09 20:03:17 [4307] [6] DEBUG: SMPP PDU 0xb1a0d948 dump: 2010-10-09 20:03:17 [4307] [6] DEBUG: type_name: deliver_sm_resp 2010-10-09 20:03:17 [4307] [6] DEBUG: command_id: 2147483653 = 0x80000005 2010-10-09 20:03:17 [4307] [6] DEBUG: command_status: 0 = 0x00000000 2010-10-09 20:03:17 [4307] [6] DEBUG: sequence_number: 20452 = 0x00004fe4 2010-10-09 20:03:17 [4307] [6] DEBUG: message_id: NULL 2010-10-09 20:03:17 [4307] [6] DEBUG: SMPP PDU dump ends.