The cat SMS service failed to start, seeking expert advice

Boot log:

2013-12-16 11:46:48.971 [INFO ] smslib {Service.java:113} - SMSLib: A Java API library for sending and receiving SMS via a GSM modem or other supported gateways.
This software is distributed under the terms of the Apache v2.0 License.
Web Site:
2013-12-16 11:46:48.976 [INFO ] smslib {Service.java:114} - Version: 3.5.3
2013-12-16 11:46:48.976 [INFO ] smslib {Service.java:115} - JRE Version: 1.6.0_37
2013-12-16 11:46:48.980 [INFO ] smslib {Service.java:116} - JRE Impl Version: 20.12-b01
2013-12-16 11:46:48.981 [INFO ] smslib {Service.java:117} - O/S: Linux / amd64 / 2.6.32-279.el6.x86_64
2013-12-16 11:46:48.987 [INFO ] smslib {SMSServer.java:158} - SMSServer: set balancer to: RoundRobinLoadBalancer
2013-12-16 11:46:49.016 [INFO ] smslib {SMSServer.java:198} - SMSServer: added gateway myModem / Default Serial Modem Gateway.
2013-12-16 11:46:49.019 [INFO ] smslib {SMSServer.java:236} - SMSServer: added interface httpServer / Default HTTP Server interface. / INOUTBOUND
2013-12-16 11:46:49.025 [INFO ] smslib {SMSServer.java:236} - SMSServer: added interface db1 / Default database interface. / INOUTBOUND
2013-12-16 11:46:51.200 [DEBUG] org.eclipse.jetty.util.log {Log.java:162} - Logging to org.slf4j.impl.Log4jLoggerAdapter(org.eclipse.jetty.util.log) via org.eclipse.jetty.util.log.Slf4jLog
2013-12-16 11:46:53.471 [INFO ] smslib {Interface.java:290} - SMSServer: interface: org.smslib.smsserver.interfaces.Database started.
2013-12-16 11:46:53.474 [INFO ] smslib {DefaultQueueManager.java:92} - Queue directory not defined. Queued messages will not be saved to filesystem.
2013-12-16 11:46:53.476 [DEBUG] smslib {AServiceThread.java:39} - Initialized.
2013-12-16 11:46:53.477 [DEBUG] smslib {AServiceThread.java:104} - Running...
2013-12-16 11:46:53.478 [DEBUG] smslib {NotifyQueueManager.java:99} - NotifyQueueManager running...
2013-12-16 11:46:53.478 [DEBUG] smslib {AServiceThread.java:39} - Initialized.
2013-12-16 11:46:53.479 [DEBUG] smslib {AServiceThread.java:104} - Running...
2013-12-16 11:46:53.479 [DEBUG] smslib {AbstractQueueManager.java:151} - DelayQueueManager running...
2013-12-16 11:46:53.479 [DEBUG] smslib {AServiceThread.java:39} - Initialized.
2013-12-16 11:46:53.481 [DEBUG] smslib {AServiceThread.java:104} - Running...
2013-12-16 11:46:53.482 [INFO ] smslib {ModemGateway.java:188} - GTW: myModem: Starting gateway, using Wavecom (Generic) AT Handler.
2013-12-16 11:46:53.482 [INFO ] smslib {SerialModemDriver.java:68} - GTW: myModem: Opening: /dev/ttyS1 @9600
2013-12-16 11:46:53.554 [DEBUG] smslib {AServiceThread.java:39} - Initialized.
2013-12-16 11:46:53.555 [DEBUG] smslib {AServiceThread.java:104} - Running...
2013-12-16 11:46:53.555 [DEBUG] smslib {AServiceThread.java:39} - Initialized.
2013-12-16 11:46:53.556 [DEBUG] smslib {AServiceThread.java:104} - ** disabled **
2013-12-16 11:46:53.557 [DEBUG] smslib {AModemDriver.java:613} - GTW: myModem: ModemReader thread started.
2013-12-16 11:46:53.560 [DEBUG] smslib {AModemDriver.java:733} - GTW: myModem: AsyncNotifier thread started.
2013-12-16 11:46:53.562 [DEBUG] smslib {AModemDriver.java:850} - GTW: myModem: AsyncMessageProcessor thread started.
2013-12-16 11:46:53.562 [DEBUG] smslib {AModemDriver.java:409} - GTW: myModem: clearBuffer() called.
2013-12-16 11:46:54.563 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :(27)
2013-12-16 11:46:54.765 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :+++
2013-12-16 11:46:54.969 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :ATZ(cr)
2013-12-16 11:46:55.175 [DEBUG] smslib {AModemDriver.java:409} - GTW: myModem: clearBuffer() called.
2013-12-16 11:46:56.175 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+CFUN=1(cr)
2013-12-16 11:47:06.188 [DEBUG] smslib {AModemDriver.java:409} - GTW: myModem: clearBuffer() called.
2013-12-16 11:47:07.188 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :ATZ(cr)
2013-12-16 11:47:07.395 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :ATE0(cr)
2013-12-16 11:47:07.601 [DEBUG] smslib {AModemDriver.java:409} - GTW: myModem: clearBuffer() called.
2013-12-16 11:47:08.481 [DEBUG] smslib {AServiceThread.java:104} - Running...
2013-12-16 11:47:08.601 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+CPIN?(cr)
2013-12-16 11:47:08.652 [DEBUG] smslib {AModemDriver.java:350} - GTW: myModem: BUFFER: ERROR
2013-12-16 11:47:08.653 [DEBUG] smslib {AModemDriver.java:390} - GTW: myModem: RECV :ERROR(cr)
2013-12-16 11:47:08.654 [WARN ] smslib {AModemDriver.java:159} - GTW: myModem: Erroneous CPIN response, proceeding with defaults.
2013-12-16 11:47:08.654 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :ATE0(cr)
2013-12-16 11:47:08.860 [DEBUG] smslib {AModemDriver.java:409} - GTW: myModem: clearBuffer() called.
2013-12-16 11:47:09.860 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+CLIP=1(cr)
2013-12-16 11:47:09.910 [DEBUG] smslib {AModemDriver.java:350} - GTW: myModem: BUFFER: ERROR
2013-12-16 11:47:09.911 [DEBUG] smslib {AModemDriver.java:390} - GTW: myModem: RECV :ERROR(cr)
2013-12-16 11:47:09.911 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+COPS=0(cr)
2013-12-16 11:47:09.961 [DEBUG] smslib {AModemDriver.java:350} - GTW: myModem: BUFFER: ERROR
2013-12-16 11:47:09.962 [DEBUG] smslib {AModemDriver.java:390} - GTW: myModem: RECV :ERROR(cr)
2013-12-16 11:47:09.962 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :ATE0(cr)
2013-12-16 11:47:10.169 [DEBUG] smslib {AModemDriver.java:409} - GTW: myModem: clearBuffer() called.
2013-12-16 11:47:11.169 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+CREG=1(cr)
2013-12-16 11:47:11.199 [DEBUG] smslib {AModemDriver.java:350} - GTW: myModem: BUFFER: OK
2013-12-16 11:47:11.200 [DEBUG] smslib {AModemDriver.java:390} - GTW: myModem: RECV :OK(cr)
2013-12-16 11:47:11.213 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+CREG?(cr)
2013-12-16 11:47:11.264 [DEBUG] smslib {AModemDriver.java:350} - GTW: myModem: BUFFER: +CREG: 0
+CREG: 1,0
OK
2013-12-16 11:47:11.265 [DEBUG] smslib {AModemDriver.java:390} - GTW: myModem: RECV :+CREG: 0(cr)+CREG: 1,0(cr)OK(cr)
2013-12-16 11:47:11.266 [ERROR] smslib {AModemDriver.java:443} - GTW: myModem: GSM: Auto-registration disabled!
2013-12-16 11:47:11.266 [DEBUG] smslib {AServiceThread.java:112} - Stopped.
2013-12-16 11:47:11.267 [DEBUG] smslib {AServiceThread.java:112} - Stopped.
2013-12-16 11:47:11.267 [DEBUG] smslib {AModemDriver.java:829} - GTW: myModem: AsyncNotifier thread ended.



Send back data:

<send>
<error>-9002</error>
<error_description>Message not sent.</error_description>
<message_status>UNSENT</message_status>
<ref_no/>
<gateway>*</gateway>
</send>

Who knows what is wrong about this? How to solve

Started by Constance at December 25, 2016 - 8:50 AM


2013-12-16 11:47:11.268 [DEBUG] smslib {AModemDriver.java:914} - GTW: myModem: AsyncMessageProcessor thread ended.
2013-12-16 11:47:11.269 [DEBUG] smslib {AModemDriver.java:658} - GTW: myModem: ModemReader thread ended.
2013-12-16 11:47:11.282 [INFO ] smslib {SerialModemDriver.java:120} - GTW: myModem: Closing: /dev/ttyS1 @9600
2013-12-16 11:47:11.485 [DEBUG] smslib {AbstractQueueManager.java:155} - DelayQueueManager end...
2013-12-16 11:47:11.486 [DEBUG] smslib {NotifyQueueManager.java:133} - NotifyQueueManager end...
2013-12-16 11:47:11.586 [DEBUG] smslib {AServiceThread.java:104} - Running...
2013-12-16 11:47:11.586 [DEBUG] smslib {NotifyQueueManager.java:99} - NotifyQueueManager running...
2013-12-16 11:47:11.686 [DEBUG] smslib {AServiceThread.java:112} - Stopped.
2013-12-16 11:47:11.686 [INFO ] smslib {ModemGateway.java:200} - GTW: myModem: Stopping gateway...
2013-12-16 11:47:11.687 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+WATH=31(cr)
2013-12-16 11:47:11.688 [ERROR] smslib {SMSServer.java:347} - SMSServer error!
java.io.IOException
at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1186)
at org.smslib.modem.SerialModemDriver.write(SerialModemDriver.java:186)
at org.smslib.modem.AModemDriver.write(AModemDriver.java:302)
at org.smslib.modem.athandler.ATHandler_Wavecom.done(ATHandler_Wavecom.java:52)
at org.smslib.modem.ModemGateway.stopGateway(ModemGateway.java:201)
at org.smslib.Service.stopService(Service.java:355)
at org.smslib.Service.startService(Service.java:234)
at org.smslib.Service.startService(Service.java:196)
at org.smslib.smsserver.SMSServer.run(SMSServer.java:342)
at org.smslib.smsserver.SMSServer.main(SMSServer.java:577)
2013-12-16 11:47:11.690 [INFO ] smslib {Interface.java:304} - SMSServer: interface: org.smslib.smsserver.interfaces.HttpServer stopped.
2013-12-16 11:47:11.693 [INFO ] smslib {Interface.java:304} - SMSServer: interface: org.smslib.smsserver.interfaces.Database stopped.
2013-12-16 11:47:11.694 [INFO ] smslib {ModemGateway.java:200} - GTW: myModem: Stopping gateway...
2013-12-16 11:47:11.694 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+WATH=31(cr)
2013-12-16 11:47:11.694 [ERROR] smslib {SMSServer.java:582} - SMSServer Error:
java.io.IOException
at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1186)
at org.smslib.modem.SerialModemDriver.write(SerialModemDriver.java:186)
at org.smslib.modem.AModemDriver.write(AModemDriver.java:302)
at org.smslib.modem.athandler.ATHandler_Wavecom.done(ATHandler_Wavecom.java:52)
at org.smslib.modem.ModemGateway.stopGateway(ModemGateway.java:201)
at org.smslib.Service.stopService(Service.java:355)
at org.smslib.smsserver.SMSServer.run(SMSServer.java:349)
at org.smslib.smsserver.SMSServer.main(SMSServer.java:577)
2013-12-16 11:47:11.695 [INFO ] smslib {ModemGateway.java:200} - GTW: myModem: Stopping gateway...
2013-12-16 11:47:11.695 [DEBUG] smslib {AModemDriver.java:301} - GTW: myModem: SEND :AT+WATH=31(cr)
2013-12-16 11:47:11.695 [ERROR] smslib {SMSServer.java:589} - SMSServer error while shutting down:
java.io.IOException
at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1186)
at org.smslib.modem.SerialModemDriver.write(SerialModemDriver.java:186)
at org.smslib.modem.AModemDriver.write(AModemDriver.java:302)
at org.smslib.modem.athandler.ATHandler_Wavecom.done(ATHandler_Wavecom.java:52)
at org.smslib.modem.ModemGateway.stopGateway(ModemGateway.java:201)
at org.smslib.Service.stopService(Service.java:355)
at org.smslib.smsserver.SMSServer.main(SMSServer.java:585)

Posted by Constance at January 05, 2017 - 9:24 AM