Good day, It seems when using the ff combination I'm always getting +CMS Error 304 when sending SMS * SMSServer 3.5.1 * Centos 5.6 using kernel-2.6.18-274.3.1.el5, * Huawei E160E
I observed that it won't allow me to send sms greater that 10 character or more (not sure on the minimum, I have not yet tested all possible count.) it will always result to CMS error 304 which means Invalid PDU Format. Here's the log showing that SMSserver is able to send the sms a four character word "test" and subsequent log showing CMS error 304 on a longer sms but still below the 160 character limit per sms. ============== << SmsSubmitPdu >> Raw Pdu: 0011000B819021940782F10000FF04F4F29C0E SMSC Address: [Length: 0 octets] First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-MMS: (has no messages), TP- RD: (allow duplicates), TP-VPF: (validity format, integer, TP-SRI: (No Status Report), TP-SRR: (No Status Report), TP-UDHI: (no UDH)] Message Reference: 00 Destination Address: [Length: 11 (0B), Type: 81 (10000001), Address: 09124970281] TP-PID: 00 (00000000) TP-DCS: 00 (7-bit GSM Alphabet) (00000000) TP-VPF: 10584 hours User Data Length: 4 (04) septets User Data (pdu) : F4F29C0E User Data (decoded): [test] ================================================= 2011-09-16 06:19:24,195 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: Sending Pdu: 0011000B819021940782F10000FF04F4F29C0E 2011-09-16 06:19:24,195 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND :AT +CMGS=18(cr) 2011-09-16 06:19:24,397 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: clearBuffer() called. 2011-09-16 06:19:25,399 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND : 0011000B819021940782F10000FF04F4F29C0E 2011-09-16 06:19:26,828 [KeepAlive [modem1]] DEBUG KeepAlive [modem1] smslib - Running... 2011-09-16 06:19:27,239 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:19:27,522 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: BUFFER: +CMGS: 225^MOK^M 2011-09-16 06:19:27,522 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: RECV :+CMGS: 225(cr)OK(cr) 2011-09-16 06:19:27,522 [KeepAlive [modem1]] DEBUG KeepAlive [modem1] smslib - GTW: modem1: SEND :AT(cr) 2011-09-16 06:19:27,524 [KeepAlive [modem1]] DEBUG KeepAlive [modem1] smslib - GTW: modem1: BUFFER: OK^M 2011-09-16 06:19:27,524 [KeepAlive [modem1]] DEBUG KeepAlive [modem1] smslib - GTW: modem1: RECV :OK(cr) 2011-09-16 06:19:32,240 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:19:33,170 [WatchDog] DEBUG WatchDog smslib - Running... 2011-09-16 06:19:37,241 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:19:37,526 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - OutboundPollingThread() run. 2011-09-16 06:19:37,537 [SMSServer - OutboundPollingThread] INFO SMSServer - OutboundPollingThread smslib - SMSServer: sending synchronously... 2011-09-16 06:19:42,242 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:19:47,243 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:19:47,538 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - OutboundPollingThread() run. 2011-09-16 06:19:47,549 [SMSServer - OutboundPollingThread] INFO SMSServer - OutboundPollingThread smslib - SMSServer: sending synchronously... 2011-09-16 06:19:48,171 [WatchDog] DEBUG WatchDog smslib - Running... 2011-09-16 06:19:52,244 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:19:53,737 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - Running... 2011-09-16 06:19:53,737 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: SEND :AT +CPMS="SM"(cr) 2011-09-16 06:19:53,741 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: BUFFER: +CPMS: 1,30,1,30,1,30^MOK^M 2011-09-16 06:19:53,741 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: RECV :+CPMS: 1,30,1,30,1,30(cr)OK(cr) 2011-09-16 06:19:53,741 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: SEND :AT +CMGL=4(cr) 2011-09-16 06:19:54,030 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: BUFFER: +CMGL: 0,0,,23^M0791361908005092040C9136194279201800001190618161912304F4F29C0E^MOK^M 2011-09-16 06:19:54,030 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: RECV :+CMGL: 0,0,,23(cr)0791361908005092040C9136194279201800001190618161912304F4F29C0E(cr)OK(cr) 2011-09-16 06:19:54,030 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: READ PDU: 0791361908005092040C9136194279201800001190618161912304F4F29C0E 2011-09-16 06:19:54,033 [CNMIEmulatorProcessor [modem1]] DEBUG CNMIEmulatorProcessor [modem1] smslib - GTW: modem1: ================================================= some other logs here...... ============== << SmsSubmitPdu >> Raw Pdu: 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 SMSC Address: [Length: 0 octets] First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-MMS: (has no messages), TP- RD: (allow duplicates), TP-VPF: (validity format, integer, TP-SRI: (No Status Report), TP-SRR: (No Status Report), TP-UDHI: (no UDH)] Message Reference: 00 Destination Address: [Length: 12 (0C), Type: 81 (10000001), Address: 639124970281] TP-PID: 00 (00000000) TP-DCS: 00 (7-bit GSM Alphabet) (00000000) TP-VPF: 10584 hours User Data Length: 126 (7E) septets User Data (pdu) : F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 User Data (decoded): [testtesttesttesttesttest, testtesttesttesttesttest testtesttesttesttesttest testtesttesttesttesttest testtesttesttesttesttest] ================================================= 2011-09-16 06:23:44,327 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: Sending Pdu: 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 2011-09-16 06:23:44,327 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND :AT +CMGS=125(cr) 2011-09-16 06:23:44,530 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: clearBuffer() called. 2011-09-16 06:23:45,532 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND : 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 2011-09-16 06:23:45,535 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: BUFFER: +CMS ERROR: 304^M 2011-09-16 06:23:45,535 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: RECV :+CMS ERROR: 304(cr) 2011-09-16 06:23:45,535 [SMSServer - OutboundPollingThread] WARN SMSServer - OutboundPollingThread smslib - GTW: modem1: CMS Error 304: Retrying... 2011-09-16 06:23:47,337 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:23:48,246 [WatchDog] DEBUG WatchDog smslib - Running... 2011-09-16 06:23:48,537 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND :AT +CMGS=125(cr) 2011-09-16 06:23:48,746 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: clearBuffer() called. 2011-09-16 06:23:49,748 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND : 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 2011-09-16 06:23:49,751 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: BUFFER: +CMS ERROR: 304^M 2011-09-16 06:23:49,751 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: RECV :+CMS ERROR: 304(cr) 2011-09-16 06:23:49,751 [SMSServer - OutboundPollingThread] WARN SMSServer - OutboundPollingThread smslib - GTW: modem1: CMS Error 304: Retrying... 2011-09-16 06:23:52,338 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-16 06:23:52,753 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND :AT +CMGS=125(cr) 2011-09-16 06:23:52,955 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: clearBuffer() called. 2011-09-16 06:23:53,957 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND : 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 2011-09-16 06:23:53,960 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: BUFFER: +CMS ERROR: 304^M 2011-09-16 06:23:53,960 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: RECV :+CMS ERROR: 304(cr) 2011-09-16 06:23:53,960 [SMSServer - OutboundPollingThread] ERROR SMSServer - OutboundPollingThread smslib - GTW: modem1: CMS Error 304: Quit retrying, message lost... Now when I updated the kernel of that same machine to 2.6.39-4.el5. which i found on elrepo that problem is gone when sending longer sms and even multipart sms. here's the log using the same sms. ============== << SmsSubmitPdu >> Raw Pdu: 0011000B819021940782F10000FF04F4F29C0E SMSC Address: [Length: 0 octets] First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-MMS: (has no messages), TP- RD: (allow duplicates), TP-VPF: (validity format, integer, TP-SRI: (No Status Report), TP-SRR: (No Status Report), TP-UDHI: (no UDH)] Message Reference: 00 Destination Address: [Length: 11 (0B), Type: 81 (10000001), Address: 09124970281] TP-PID: 00 (00000000) TP-DCS: 00 (7-bit GSM Alphabet) (00000000) TP-VPF: 10584 hours User Data Length: 4 (04) septets User Data (pdu) : F4F29C0E User Data (decoded): [test] ================================================= 2011-09-17 00:54:28,234 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: Sending Pdu: 0011000B819021940782F10000FF04F4F29C0E 2011-09-17 00:54:28,234 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND :AT +CMGS=18(cr) 2011-09-17 00:54:28,435 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: clearBuffer() called. 2011-09-17 00:54:29,435 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND : 0011000B819021940782F10000FF04F4F29C0E 2011-09-17 00:54:31,427 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: BUFFER: +CMGS: 250^MOK^M 2011-09-17 00:54:31,427 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: RECV :+CMGS: 250(cr)OK(cr) some other logs here.... ============== << SmsSubmitPdu >> Raw Pdu: 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 SMSC Address: [Length: 0 octets] First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-MMS: (has no messages), TP- RD: (allow duplicates), TP-VPF: (validity format, integer, TP-SRI: (No Status Report), TP-SRR: (No Status Report), TP-UDHI: (no UDH)] Message Reference: 00 Destination Address: [Length: 12 (0C), Type: 81 (10000001), Address: 639124970281] TP-PID: 00 (00000000) TP-DCS: 00 (7-bit GSM Alphabet) (00000000) TP-VPF: 10584 hours User Data Length: 126 (7E) septets User Data (pdu) : F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 User Data (decoded): [testtesttesttesttesttest, testtesttesttesttesttest testtesttesttesttesttest testtesttesttesttesttest testtesttesttesttesttest] ================================================= 2011-09-17 00:55:34,937 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: Sending Pdu: 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 2011-09-17 00:55:34,938 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND :AT +CMGS=125(cr) 2011-09-17 00:55:35,138 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: clearBuffer() called. 2011-09-17 00:55:36,138 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: SEND : 0011000C813619427920180000FF7EF4F29C4E2FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE92C10BD3CA7D3CB733ABD3CA7D3CB733ABD3CA7D3CB733A08442FCFE9F4F29C4E2FCFE9F4F29C4E2FCFE9F4F29CAEA097E7747A794EA797E7747A794EA797E7747A794E07D1CB733ABD3CA7D3CB733ABD3CA7D3CB733ABD3CA703 2011-09-17 00:55:37,307 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-17 00:55:38,512 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: BUFFER: +CMGS: 252^MOK^M 2011-09-17 00:55:38,512 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - GTW: modem1: RECV :+CMGS: 252(cr)OK(cr) 2011-09-17 00:55:42,309 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-17 00:55:47,309 [QueueManager [modem1]] DEBUG QueueManager [modem1] smslib - Running... 2011-09-17 00:55:48,459 [WatchDog] DEBUG WatchDog smslib - Running... 2011-09-17 00:55:48,514 [SMSServer - OutboundPollingThread] DEBUG SMSServer - OutboundPollingThread smslib - OutboundPollingThread() run. not sure if the usbserial.ko kernel driver is the culprit or what, as I have not tested a newer usbserial from source and compile it under 2.6.18. Any advise? TIA. -- You received this message because you are subscribed to the Google Groups "SMSLib Discussion Group" group. To post to this group, send email to [email protected]. To unsubscribe from this group, send email to [email protected]. For more options, visit this group at http://groups.google.com/group/smslib?hl=en.
