thanks for that, i however dont know if the output is the best. Here is the log
2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CPMS?^M 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CPMS? 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- +CPMS: "SM",2,20,"SM",2,20,"SM",2,20 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: 2 messages waiting in memory 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=1^M 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=1 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- +CMGR: 0,,138 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- 07915274220500920410D0D3B0392C4F8FDF6D00000110307110702185D3B75C9E7781B2EF3A081DB6974169F7BC6E36A7C7E9B29B0E32D7DDE43988FE06D5E765101D9D9E83E665B93D3D2EBB40493328FFAE83EEEF3A9B0C62A7D76510FD0D9297C7E5B4BD0CAAC15E2D50382DA7A7DB6550986C0FBBC765D03D4D47839EEB7718A40CA3C3FA34889C0EB341AAD82C3602 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: received message from SMSC: +254722500029 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: Alphanumeric sender <Safaricom> 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: User data length read as (133) 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: Udh decoding done len=133 udhi=0 udhlen=0 udh='' 2010-01-04 11:25:27 [3737] [17] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2010-01-04 11:25:27 [3737] [17] DEBUG: boxc_sender: sent message to <127.0.0.1> 2010-01-04 11:25:27 [3737] [16] DEBUG: boxc_receiver: sms received 2010-01-04 11:25:27 [3737] [16] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2010-01-04 11:25:27 [3737] [16] DEBUG: boxc_receiver: got ack 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGD=1^M 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGD=1 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=2^M 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=2 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=3^M 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=3 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=4^M 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FE2,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=4 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=5^M 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=5 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:27 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=6^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=6 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=7^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=7 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=8^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=8 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=9^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=9 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=10^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=10 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=11^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=11 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=12^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=12 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=13^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=13 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=14^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=14 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=15^M 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=15 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:28 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=16^M 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=16 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=17^M 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^MODE:3,3 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=17 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=18^M 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=18 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=19^M 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=19 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=20^M 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=20 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- +CMS ERROR: 321 2010-01-04 11:25:29 [3737] [7] ERROR: AT2[Huawei-E220]: CMS ERROR: +CMS ERROR: 321 2010-01-04 11:25:29 [3737] [7] ERROR: AT2[Huawei-E220]: CMS ERROR: Invalid memory index -> don't worry, just memory fragmentation. (321) 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: failed to get message 20. 2010-01-04 11:25:29 [3737] [7] ERROR: AT2[Huawei-E220]: Error encoding PDU! 2010-01-04 11:25:29 [3737] [7] ERROR: System error 2: No such file or directory 2010-01-04 11:25:29 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FE4,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:31 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FE6,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:33 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FE8,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:35 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FEA,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:37 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FEC,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:39 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FEE,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT^M 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CPMS?^M 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CPMS? 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- +CPMS: "SM",3,20,"SM",3,20,"SM",3,20 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: 3 messages waiting in memory 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=1^M 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=1 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- +CMGR: 0,,138 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- 07915274220500920410D0D3B0392C4F8FDF6D00000110307110412185D3B75C9E7781B2EF3A081DB6974169F7BC6E36A7C7E9B29B0E32D7DDE43988FE06D5E765101D9D9E83E665B93D3D2EBB40493328FFAE83EEEF3A9B0C62A7D76510FD0D9297C7E5B4BD0CAAC15E2D50382DA7A7DB6550986C0FBBC765D03D4D47839EEB7718A40CA3C3FA34889C0EB341AAD82C3602 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: received message from SMSC: +254722500029 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: Alphanumeric sender <Safaricom> 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: User data length read as (133) 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: Udh decoding done len=133 udhi=0 udhlen=0 udh='' 2010-01-04 11:25:41 [3737] [17] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2010-01-04 11:25:41 [3737] [17] DEBUG: boxc_sender: sent message to <127.0.0.1> 2010-01-04 11:25:41 [3737] [16] DEBUG: boxc_receiver: sms received 2010-01-04 11:25:41 [3737] [16] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2010-01-04 11:25:41 [3737] [16] DEBUG: boxc_receiver: got ack 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGD=1^M 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^MODE:3,3 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGD=1 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=2^M 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=2 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- +CMGR: 0,,138 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- 07915274220500920410D0D3B0392C4F8FDF6D00000110307110632185D3B75C9E7781B2EF3A081DB6974169F7BC6E36A7C7E9B29B0E32D7DDE43988FE06D5E765101D9D9E83E665B93D3D2EBB40493328FFAE83EEEF3A9B0C62A7D76510FD0D9297C7E5B4BD0CAAC15E2D50382DA7A7DB6550986C0FBBC765D03D4D47839EEB7718A40CA3C3FA34889C0EB341AAD82C3602 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: received message from SMSC: +254722500029 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: Alphanumeric sender <Safaricom> 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: User data length read as (133) 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: Udh decoding done len=133 udhi=0 udhlen=0 udh='' 2010-01-04 11:25:41 [3737] [17] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2010-01-04 11:25:41 [3737] [17] DEBUG: boxc_sender: sent message to <127.0.0.1> 2010-01-04 11:25:41 [3737] [16] DEBUG: boxc_receiver: sms received 2010-01-04 11:25:41 [3737] [16] DEBUG: send_msg: sending msg to box: <127.0.0.1> 2010-01-04 11:25:41 [3737] [16] DEBUG: boxc_receiver: got ack 2010-01-04 11:25:41 [3737] [6] DEBUG: SMPP[ESTUDENT-SMS]: Sending PDU: 2010-01-04 11:25:41 [3737] [6] DEBUG: SMPP PDU 0xb5e0aea0 dump: 2010-01-04 11:25:41 [3737] [6] DEBUG: type_name: submit_sm 2010-01-04 11:25:41 [3737] [6] DEBUG: command_id: 4 = 0x00000004 2010-01-04 11:25:41 [3737] [6] DEBUG: command_status: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: sequence_number: 124 = 0x0000007c 2010-01-04 11:25:41 [3737] [6] DEBUG: service_type: NULL 2010-01-04 11:25:41 [3737] [6] DEBUG: source_addr_ton: 2 = 0x00000002 2010-01-04 11:25:41 [3737] [6] DEBUG: source_addr_npi: 1 = 0x00000001 2010-01-04 11:25:41 [3737] [6] DEBUG: source_addr: "0717801082" 2010-01-04 11:25:41 [3737] [6] DEBUG: dest_addr_ton: 2 = 0x00000002 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:41 [3737] [6] DEBUG: dest_addr_npi: 1 = 0x00000001 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGD=2^M 2010-01-04 11:25:41 [3737] [6] DEBUG: destination_addr: "Safaricom" 2010-01-04 11:25:41 [3737] [6] DEBUG: esm_class: 3 = 0x00000003 2010-01-04 11:25:41 [3737] [6] DEBUG: protocol_id: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: priority_flag: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: schedule_delivery_time: NULL 2010-01-04 11:25:41 [3737] [6] DEBUG: validity_period: NULL 2010-01-04 11:25:41 [3737] [6] DEBUG: registered_delivery: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: replace_if_present_flag: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: data_coding: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: sm_default_msg_id: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: sm_length: 14 = 0x0000000e 2010-01-04 11:25:41 [3737] [6] DEBUG: short_message: "Request Failed" 2010-01-04 11:25:41 [3737] [6] DEBUG: SMPP PDU dump ends. 2010-01-04 11:25:41 [3737] [6] DEBUG: SMPP[ESTUDENT-SMS]: Got PDU: 2010-01-04 11:25:41 [3737] [6] DEBUG: SMPP PDU 0xb5e0aea0 dump: 2010-01-04 11:25:41 [3737] [6] DEBUG: type_name: submit_sm_resp 2010-01-04 11:25:41 [3737] [6] DEBUG: command_id: 2147483652 = 0x80000004 2010-01-04 11:25:41 [3737] [6] DEBUG: command_status: 0 = 0x00000000 2010-01-04 11:25:41 [3737] [6] DEBUG: sequence_number: 124 = 0x0000007c 2010-01-04 11:25:41 [3737] [6] DEBUG: message_id: "105" 2010-01-04 11:25:41 [3737] [6] DEBUG: SMPP PDU dump ends. 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- ^DSFLOWRPT:00000FF0,00000000,00000000,000000000005CA36,000000000031B54B,0003E800,0000E678 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGD=2 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=3^M 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=3 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:41 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=4^M 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=4 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=5^M 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=5 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=6^M 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=6 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: --> AT+CMGR=7^M 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- AT+CMGR=7 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: <-- OK 2010-01-04 11:25:42 [3737] [7] DEBUG: AT2[Huawei-E220]: not deleted. However, their is something else that might interest you,Here is a section of kannel_access.log 2010-01-04 11:20:39 Receive SMS [SMSC:Huawei-E220] [SVC:] [ACT:] [BINF:] [FID:] [from:Safaricom] [to:0717801082] [flags:-1:0:-1:0:-1] [msg:133:Sorry. You have insufficient funds to use this service. If you would like to receive 50/- airtime advance with Okoa Jahazi dial *131#] [udh:0:] 2010-01-04 11:20:39 Sent SMS [SMSC:ESTUDENT-SMS] [SVC:] [ACT:] [BINF:] [FID:] [from:0717801082] [to:Safaricom] [flags:-1:0:-1:-1:-1] [msg:14:Request Failed] [udh:0:] 2010-01-04 11:20:53 Receive SMS [SMSC:Huawei-E220] [SVC:] [ACT:] [BINF:] [FID:] [from:Safaricom] [to:0717801082] [flags:-1:0:-1:0:-1] [msg:133:Sorry. You have insufficient funds to use this service. If you would like to receive 50/- airtime advance with Okoa Jahazi dial *131#] [udh:0:] 2010-01-04 11:20:53 Sent SMS [SMSC:ESTUDENT-SMS] [SVC:] [ACT:] [BINF:] [FID:] [from:0717801082] [to:Safaricom] [flags:-1:0:-1:-1:-1] [msg:14:Request Failed] [udh:0:] 2010-01-04 11:20:53 Receive SMS [SMSC:Huawei-E220] [SVC:] [ACT:] [BINF:] [FID:] [from:Safaricom] [to:0717801082] [flags:-1:0:-1:0:-1] [msg:133:Sorry. You have insufficient funds to use this service. If you would like to receive 50/- airtime advance with Okoa Jahazi dial *131#] [udh:0:] ........................................................... Thats a message from my service provider ,an automatic reply we receive when we try to send a message with insufficient funds on the phone. Maybe the SMPP simulator(smpp smsc) log will also help, this is where the modem gsm_smsc is routing the messages to 2010.01.04 11:56:35 268 INFO 20 : BIND_TRANSCEIVER: 2010.01.04 11:56:35 268 INFO 20 Hex dump (41) bytes: 2010.01.04 11:56:35 268 INFO 20 00000029:00000009:00000000:00000001: 2010.01.04 11:56:35 269 INFO 20 6E6D7669:636B7900:6E6D7669:636B7900: 2010.01.04 11:56:35 269 INFO 20 564D4100:34000030:00 2010.01.04 11:56:35 270 INFO 20 cmd_len=41,cmd_id=9,cmd_status=0,seq_no=1,system_id=nmvicky,password=nmvicky 2010.01.04 11:56:35 270 INFO 20 system_type=VMA,interface_version=52,addr_ton=0,addr_npi=0,address_range=0 2010.01.04 11:56:35 270 INFO 20 2010.01.04 11:56:35 270 INFO 20 StandardProtocolHandler: setting address range to 0 2010.01.04 11:56:35 271 INFO 20 Made RE for 0 2010.01.04 11:56:35 271 INFO 20 New transceiver session bound to SMPPSim 2010.01.04 11:56:35 271 INFO 20 : BIND_TRANSCEIVER_RESP: 2010.01.04 11:56:35 272 INFO 20 Hex dump (24) bytes: 2010.01.04 11:56:35 272 INFO 20 00000018:80000009:00000000:00000001: 2010.01.04 11:56:35 272 INFO 20 534D5050:53696D00: 2010.01.04 11:56:35 272 INFO 20 cmd_len=0,cmd_id=-2147483639,cmd_status=0,seq_no=1,system_id=SMPPSim 2010.01.04 11:56:35 273 INFO 20 2010.01.04 11:56:35 273 INFO 20 1 receivers connected and bound 2010.01.04 11:56:35 273 INFO 22 InboundQueue: empty - waiting 2010.01.04 11:56:45 379 INFO 20 : UNBIND: 2010.01.04 11:56:45 379 INFO 20 Hex dump (16) bytes: 2010.01.04 11:56:45 380 INFO 20 00000010:00000006:00000000:00000002: 2010.01.04 11:56:45 380 INFO 20 2010.01.04 11:56:45 380 INFO 20 cmd_len=16,cmd_id=6,cmd_status=0,seq_no=2 2010.01.04 11:56:45 381 INFO 20 2010.01.04 11:56:45 381 INFO 20 0 receivers connected and bound 2010.01.04 11:56:45 381 INFO 20 : UNBIND_RESP 2010.01.04 11:56:45 381 INFO 20 Hex dump (16) bytes: 2010.01.04 11:56:45 382 INFO 20 00000010:80000006:00000000:00000002: 2010.01.04 11:56:45 382 INFO 20 2010.01.04 11:56:45 382 INFO 20 cmd_len=0,cmd_id=-2147483642,cmd_status=0,seq_no=2 2010.01.04 11:56:45 382 INFO 20 2010.01.04 11:56:45 383 INFO 20 StandardConnectionHandler waiting for connection 2010.01.04 11:56:48 512 INFO 23 Processing 0 messages in the delayed inbound queue 2010.01.04 11:57:05 668 INFO 19 StandardConnectionHandler accepted a connection 2010.01.04 11:57:05 668 INFO 19 Protocol handler is of type StandardProtocolHandler 2010.01.04 11:57:05 670 INFO 19 : BIND_TRANSCEIVER: 2010.01.04 11:57:05 671 INFO 19 Hex dump (41) bytes: 2010.01.04 11:57:05 671 INFO 19 00000029:00000009:00000000:00000001: 2010.01.04 11:57:05 671 INFO 19 6E6D7669:636B7900:6E6D7669:636B7900: 2010.01.04 11:57:05 672 INFO 19 564D4100:34000030:00 2010.01.04 11:57:05 672 INFO 19 cmd_len=41,cmd_id=9,cmd_status=0,seq_no=1,system_id=nmvicky,password=nmvicky 2010.01.04 11:57:05 672 INFO 19 system_type=VMA,interface_version=52,addr_ton=0,addr_npi=0,address_range=0 2010.01.04 11:57:05 673 INFO 19 2010.01.04 11:57:05 673 INFO 19 StandardProtocolHandler: setting address range to 0 2010.01.04 11:57:05 673 INFO 19 Made RE for 0 2010.01.04 11:57:05 673 INFO 19 New transceiver session bound to SMPPSim 2010.01.04 11:57:05 674 INFO 19 : BIND_TRANSCEIVER_RESP: 2010.01.04 11:57:05 674 INFO 19 Hex dump (24) bytes: 2010.01.04 11:57:05 674 INFO 19 00000018:80000009:00000000:00000001: 2010.01.04 11:57:05 675 INFO 19 534D5050:53696D00: 2010.01.04 11:57:05 675 INFO 19 cmd_len=0,cmd_id=-2147483639,cmd_status=0,seq_no=1,system_id=SMPPSim 2010.01.04 11:57:05 675 INFO 19 2010.01.04 11:57:05 675 INFO 19 1 receivers connected and bound 2010.01.04 11:57:05 676 INFO 22 InboundQueue: empty - waiting 2010.01.04 11:57:35 704 INFO 19 : ENQUIRE_LINK: 2010.01.04 11:57:35 705 INFO 19 Hex dump (16) bytes: 2010.01.04 11:57:35 705 INFO 19 00000010:00000015:00000000:00000002: 2010.01.04 11:57:35 705 INFO 19 2010.01.04 11:57:35 706 INFO 19 cmd_len=16,cmd_id=21,cmd_status=0,seq_no=2 2010.01.04 11:57:35 706 INFO 19 2010.01.04 11:57:35 706 INFO 19 :ENQUIRE_LINK_RESP: 2010.01.04 11:57:35 706 INFO 19 Hex dump (16) bytes: 2010.01.04 11:57:35 707 INFO 19 00000010:80000015:00000000:00000002: 2010.01.04 11:57:35 707 INFO 19 2010.01.04 11:57:35 707 INFO 19 cmd_len=0,cmd_id=-2147483627,cmd_status=0,seq_no=2 2010.01.04 11:57:35 707 INFO 19 2010.01.04 11:57:43 543 INFO 19 : Standard SUBMIT_SM: 2010.01.04 11:57:43 543 INFO 19 Hex dump (66) bytes: 2010.01.04 11:57:43 543 INFO 19 00000042:00000004:00000000:00000003: 2010.01.04 11:57:43 544 INFO 19 00020130:37313738:30313038:32000201: 2010.01.04 11:57:43 544 INFO 19 53616661:7269636F:6D000300:00000000: 2010.01.04 11:57:43 544 INFO 19 0000000E:52657175:65737420:4661696C: 2010.01.04 11:57:43 545 INFO 19 6564 2010.01.04 11:57:43 546 INFO 19 cmd_len=66,cmd_id=4,cmd_status=0,seq_no=3,service_type=,source_addr_ton=2 2010.01.04 11:57:43 547 INFO 19 source_addr_npi=1,source_addr=0717801082,dest_addr_ton=2,dest_addr_npi=1 2010.01.04 11:57:43 547 INFO 19 dest_addr=Safaricom,esm_class=3,protocol_ID=0,priority_flag=0 2010.01.04 11:57:43 547 INFO 19 schedule_delivery_time=,validity_period=,registered_delivery_flag=0 2010.01.04 11:57:43 547 INFO 19 replace_if_present_flag=0,data_coding=0,sm_default_msg_id=0,sm_length=14 2010.01.04 11:57:43 548 INFO 19 short_message=Request Failed 2010.01.04 11:57:43 548 INFO 19 2010.01.04 11:57:43 571 INFO 19 Validity period is not set: defaulting to 5 minutes from now 2010.01.04 11:57:43 575 INFO 19 Generated default validity period=100104120243000+ 2010.01.04 11:57:43 576 INFO 19 :SUBMIT_SM_RESP: 2010.01.04 11:57:43 576 INFO 24 Assessing state of 1 messages in the OutboundQueue 2010.01.04 11:57:43 577 INFO 19 Hex dump (18) bytes: 2010.01.04 11:57:43 577 INFO 19 00000012:80000004:00000000:00000003: 2010.01.04 11:57:43 577 INFO 19 3000 2010.01.04 11:57:43 577 INFO 19 cmd_len=0,cmd_id=-2147483644,cmd_status=0,seq_no=3,message_id=0 2010.01.04 11:57:43 578 INFO 19 2010.01.04 11:57:43 579 INFO 19 SubmitSM processing - response written to connection 2010.01.04 11:57:43 770 INFO 19 : Standard SUBMIT_SM: 2010.01.04 11:57:43 771 INFO 19 Hex dump (66) bytes: 2010.01.04 11:57:43 771 INFO 19 00000042:00000004:00000000:00000004: 2010.01.04 11:57:43 771 INFO 19 00020130:37313738:30313038:32000201: 2010.01.04 11:57:43 772 INFO 19 53616661:7269636F:6D000300:00000000: 2010.01.04 11:57:43 772 INFO 19 0000000E:52657175:65737420:4661696C: 2010.01.04 11:57:43 772 INFO 19 6564 2010.01.04 11:57:43 773 INFO 19 cmd_len=66,cmd_id=4,cmd_status=0,seq_no=4,service_type=,source_addr_ton=2 2010.01.04 11:57:43 773 INFO 19 source_addr_npi=1,source_addr=0717801082,dest_addr_ton=2,dest_addr_npi=1 2010.01.04 11:57:43 773 INFO 19 dest_addr=Safaricom,esm_class=3,protocol_ID=0,priority_flag=0 2010.01.04 11:57:43 773 INFO 19 schedule_delivery_time=,validity_period=,registered_delivery_flag=0 2010.01.04 11:57:43 774 INFO 19 replace_if_present_flag=0,data_coding=0,sm_default_msg_id=0,sm_length=14 2010.01.04 11:57:43 774 INFO 19 short_message=Request Failed 2010.01.04 11:57:43 774 INFO 19 2010.01.04 11:57:43 783 INFO 19 Validity period is not set: defaulting to 5 minutes from now 2010.01.04 11:57:43 784 INFO 19 Generated default validity period=100104120243000+ 2010.01.04 11:57:43 784 INFO 19 :SUBMIT_SM_RESP: 2010.01.04 11:57:43 785 INFO 19 Hex dump (18) bytes: 2010.01.04 11:57:43 785 INFO 19 00000012:80000004:00000000:00000004: 2010.01.04 11:57:43 785 INFO 19 3100 2010.01.04 11:57:43 785 INFO 19 cmd_len=0,cmd_id=-2147483644,cmd_status=0,seq_no=4,message_id=1 2010.01.04 11:57:43 785 INFO 19 2010.01.04 11:57:43 786 INFO 19 SubmitSM processing - response written to connection 2010.01.04 11:57:48 512 INFO 23 Processing 0 messages in the delayed inbound queue 2010.01.04 11:57:48 576 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:57:53 576 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:57:58 576 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:58:03 576 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:58:05 804 INFO 19 : ENQUIRE_LINK: 2010.01.04 11:58:05 804 INFO 19 Hex dump (16) bytes: 2010.01.04 11:58:05 805 INFO 19 00000010:00000015:00000000:00000005: 2010.01.04 11:58:05 805 INFO 19 2010.01.04 11:58:05 805 INFO 19 cmd_len=16,cmd_id=21,cmd_status=0,seq_no=5 2010.01.04 11:58:05 805 INFO 19 2010.01.04 11:58:05 806 INFO 19 :ENQUIRE_LINK_RESP: 2010.01.04 11:58:05 806 INFO 19 Hex dump (16) bytes: 2010.01.04 11:58:05 810 INFO 19 00000010:80000015:00000000:00000005: 2010.01.04 11:58:05 811 INFO 19 2010.01.04 11:58:05 811 INFO 19 cmd_len=0,cmd_id=-2147483627,cmd_status=0,seq_no=5 2010.01.04 11:58:05 811 INFO 19 2010.01.04 11:58:08 576 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:58:13 577 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:58:18 578 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:58:23 579 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:58:28 580 INFO 24 Assessing state of 2 messages in the OutboundQueue 2010.01.04 11:58:33 580 INFO 24 Assessing state of 2 messages in the OutboundQueue ..................................................................... I am not good at this but i have a strong feeling that although something is happening, their is something wrong going on too.If you spot it from the log files i have provided, please write to me.I appreciate what you are doing so far.Thanks in advance.