Hi,
I working with smslib for a while and i just encountered a problem
when sending sms. When i check the log, it shows that the gateway is
restarted when the application tries to send sms. I'm using Huawei
E1552 here. The weird thing is that this behavior is not consistent.
Sometimes this does not occur and sometimes it does. Maybe someone can
help me narrow down my problem with this behavior.
Here is the log :
>>> Gateway Status change for 353143038141132, OLD: STOPPED -> NEW:
STARTING
8047 2010-03-22 18:18:50,093 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
8047 2010-03-22 18:18:50,093 [Thread-6] DEBUG
org.smslib.helper.Logger - Initialized.
8047 2010-03-22 18:18:50,093 [Thread-6] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Gateway started.
8047 2010-03-22 18:18:50,093 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
8141 2010-03-22 18:18:50,187 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
8141 2010-03-22 18:18:50,187 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
>>> Gateway Status change for 353143038141132, OLD: STARTING -> NEW: STARTED
8141 2010-03-22 18:18:50,187 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
8250 2010-03-22 18:18:50,296 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
8250 2010-03-22 18:18:50,296 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
8485 2010-03-22 18:18:50,531 [AWT-EventQueue-0] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT
+CPMS="SM"(cr)
8485 2010-03-22 18:18:50,531 [AWT-EventQueue-0] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CPMS:
0,35,0,35,0,35OK
8485 2010-03-22 18:18:50,531 [AWT-EventQueue-0] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CPMS:
0,35,0,35,0,35(cr)OK(cr)
8500 2010-03-22 18:18:50,546 [AWT-EventQueue-0] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGL=4(cr)
8500 2010-03-22 18:18:50,546 [AWT-EventQueue-0] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
8500 2010-03-22 18:18:50,546 [AWT-EventQueue-0] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
8500 2010-03-22 18:18:50,546 [AWT-EventQueue-0] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: CheckMpMsgList():
MAINLIST: 0
8516 2010-03-22 18:18:50,562 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMMS=2(cr)
8532 2010-03-22 18:18:50,578 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
8532 2010-03-22 18:18:50,578 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
8547 2010-03-22 18:18:50,593 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132:
=================================================
<< SmsSubmitPdu >>
Raw Pdu:
079136190800101011000B819099341520F10000FF17D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
SMSC Address: [Length: 7 (07) octets, Type: 91 (10010001), Address:
639180000101]
First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-RD: (allow duplicates), TP-
VPF: (validity format, integer, TP-SRR: (No Status Report), TP-UDHI:
(no UDH)]
Message Reference: 00
Destination Address: [Length: 11 (0B), Type: 81 (10000001), Address:
09994351021]
TP-PID: 00 (00000000)
TP-DCS: 00 (7-bit GSM Alphabet) (00000000)
TP-VPF: 10584 hours
User Data Length: 23 (17) septets
User Data (pdu) : D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
User Data (decoded): [Reporting modem status.]
=================================================
8547 2010-03-22 18:18:50,593 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Sending Pdu:
079136190800101011000B819099341520F10000FF17D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
8547 2010-03-22 18:18:50,593 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGS=35(cr)
8750 2010-03-22 18:18:50,796 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
9750 2010-03-22 18:18:51,796 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :
079136190800101011000B819099341520F10000FF17D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
13047 2010-03-22 18:18:55,093 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
16485 2010-03-22 18:18:58,531 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
18047 2010-03-22 18:19:00,093 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
31485 2010-03-22 18:19:13,531 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
31563 2010-03-22 18:19:13,609 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
46485 2010-03-22 18:19:28,531 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
61485 2010-03-22 18:19:43,531 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
61563 2010-03-22 18:19:43,609 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
61563 2010-03-22 18:19:43,609 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
76485 2010-03-22 18:19:58,531 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
84844 2010-03-22 18:20:06,890 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Buffer contents on
timeout: +CMS ERROR: 500
84844 2010-03-22 18:20:06,890 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT(cr)
84844 2010-03-22 18:20:06,890 [Timer-2] WARN
org.smslib.helper.Logger - sendMessage(): Gateway 353143038141132
does not respond, marking for restart.
>>> Gateway Status change for 353143038141132, OLD: STARTED -> NEW: RESTART
84844 2010-03-22 18:20:06,890 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
84844 2010-03-22 18:20:06,890 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
84844 2010-03-22 18:20:06,890 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
84844 2010-03-22 18:20:06,890 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMMS=2(cr)
84844 2010-03-22 18:20:06,890 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
84844 2010-03-22 18:20:06,890 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
84844 2010-03-22 18:20:06,890 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132:
=================================================
<< SmsSubmitPdu >>
Raw Pdu:
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
SMSC Address: [Length: 7 (07) octets, Type: 91 (10010001), Address:
639180000101]
First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-RD: (allow duplicates), TP-
VPF: (validity format, integer, TP-SRR: (No Status Report), TP-UDHI:
(no UDH)]
Message Reference: 00
Destination Address: [Length: 11 (0B), Type: 81 (10000001), Address:
09994351021]
TP-PID: 00 (00000000)
TP-DCS: 00 (7-bit GSM Alphabet) (00000000)
TP-VPF: 10584 hours
User Data Length: 42 (2A) septets
User Data (pdu) :
73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
User Data (decoded): [stress test on javelin... message count: 1]
=================================================
84844 2010-03-22 18:20:06,890 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Sending Pdu:
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
84844 2010-03-22 18:20:06,890 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGS=51(cr)
84938 2010-03-22 18:20:06,984 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
84938 2010-03-22 18:20:06,984 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
85047 2010-03-22 18:20:07,093 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
86047 2010-03-22 18:20:08,093 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
91485 2010-03-22 18:20:13,531 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
91485 2010-03-22 18:20:13,531 [WatchDog] WARN
org.smslib.helper.Logger - Gateway: 353143038141132 restarting.
91485 2010-03-22 18:20:13,531 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Stopping gateway...
91485 2010-03-22 18:20:13,531 [QueueManager [353143038141132]] WARN
org.smslib.helper.Logger - GTW: 353143038141132: Re-throwing
InterruptedException in Queue.peek() - should be during shutdown...
java.lang.InterruptedException
at java.lang.Object.wait(Native Method)
at org.smslib.modem.AModemDriver
$CharQueue.peek(AModemDriver.java:556)
at org.smslib.modem.AModemDriver.getResponse(AModemDriver.java:
323)
at
org.smslib.modem.athandler.ATHandler.sendMessage(ATHandler.java:307)
at
org.smslib.modem.ModemGateway.sendMessagePDU(ModemGateway.java:480)
at org.smslib.modem.ModemGateway.sendMessage(ModemGateway.java:
241)
at org.smslib.AGateway$QueueManager.process(AGateway.java:510)
at org.smslib.threading.AServiceThread.run(AServiceThread.java:
117)
91485 2010-03-22 18:20:13,531 [QueueManager [353143038141132]] WARN
org.smslib.helper.Logger - GTW: 353143038141132: GetResponse()
Interrupted.
java.lang.InterruptedException
at org.smslib.modem.AModemDriver
$CharQueue.peek(AModemDriver.java:566)
at org.smslib.modem.AModemDriver.getResponse(AModemDriver.java:
323)
at
org.smslib.modem.athandler.ATHandler.sendMessage(ATHandler.java:307)
at
org.smslib.modem.ModemGateway.sendMessagePDU(ModemGateway.java:480)
at org.smslib.modem.ModemGateway.sendMessage(ModemGateway.java:
241)
at org.smslib.AGateway$QueueManager.process(AGateway.java:510)
at org.smslib.threading.AServiceThread.run(AServiceThread.java:
117)
91563 2010-03-22 18:20:13,609 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
>>> Gateway Status change for 353143038141132, OLD: RESTART -> NEW: STOPPING
91782 2010-03-22 18:20:13,828 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
91782 2010-03-22 18:20:13,828 [QueueManager [353143038141132]] INFO
org.smslib.helper.Logger - GTW: 353143038141132: QueueManager
interrupted.
java.lang.InterruptedException
at org.smslib.modem.AModemDriver
$CharQueue.peek(AModemDriver.java:566)
at org.smslib.modem.AModemDriver.getResponse(AModemDriver.java:
323)
at
org.smslib.modem.athandler.ATHandler.sendMessage(ATHandler.java:307)
at
org.smslib.modem.ModemGateway.sendMessagePDU(ModemGateway.java:480)
at org.smslib.modem.ModemGateway.sendMessage(ModemGateway.java:
241)
at org.smslib.AGateway$QueueManager.process(AGateway.java:510)
at org.smslib.threading.AServiceThread.run(AServiceThread.java:
117)
91891 2010-03-22 18:20:13,937 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
91891 2010-03-22 18:20:13,937 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
96797 2010-03-22 18:20:18,843 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - Stopped.
96797 2010-03-22 18:20:18,843 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - Stopped.
>>> Gateway Status change for 353143038141132, OLD: STOPPING -> NEW: STOPPED
96797 2010-03-22 18:20:18,843 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
96797 2010-03-22 18:20:18,843 [SMSLib-AsyncNotifier :
353143038141132] DEBUG org.smslib.helper.Logger - GTW:
353143038141132: AsyncNotifier thread ended.
96797 2010-03-22 18:20:18,843 [SMSLib-AsyncMessageProcessor :
353143038141132] DEBUG org.smslib.helper.Logger - GTW:
353143038141132: AsyncMessageProcessor thread ended.
96797 2010-03-22 18:20:18,843 [SMSlib-ModemReader-353143038141132]
DEBUG org.smslib.helper.Logger - GTW: 353143038141132: ModemReader
thread ended.
96907 2010-03-22 18:20:18,953 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
96907 2010-03-22 18:20:18,953 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
96985 2010-03-22 18:20:19,031 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Closing: COM42 @9600
96985 2010-03-22 18:20:19,031 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Gateway stopped.
96985 2010-03-22 18:20:19,031 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Starting gateway,
using Huawei (Generic) AT Handler.
96985 2010-03-22 18:20:19,031 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Opening: COM42 @9600
>>> Gateway Status change for 353143038141132, OLD: STOPPED -> NEW: RESTART
96985 2010-03-22 18:20:19,031 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
96985 2010-03-22 18:20:19,031 [WatchDog] DEBUG
org.smslib.helper.Logger - Initialized.
96985 2010-03-22 18:20:19,031 [WatchDog] DEBUG
org.smslib.helper.Logger - Initialized.
96985 2010-03-22 18:20:19,031 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
96985 2010-03-22 18:20:19,031 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: ModemReader thread
started.
96985 2010-03-22 18:20:19,031 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: AsyncNotifier thread
started.
96985 2010-03-22 18:20:19,031 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132:
AsyncMessageProcessor thread started.
96985 2010-03-22 18:20:19,031 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
96985 2010-03-22 18:20:19,031 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
97079 2010-03-22 18:20:19,125 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
97079 2010-03-22 18:20:19,125 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
97985 2010-03-22 18:20:20,031 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :(27)
98188 2010-03-22 18:20:20,234 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :+++
98391 2010-03-22 18:20:20,437 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATZ(cr)
98594 2010-03-22 18:20:20,640 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
99594 2010-03-22 18:20:21,640 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATZ(cr)
99797 2010-03-22 18:20:21,843 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATE0(cr)
100000 2010-03-22 18:20:22,046 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
101000 2010-03-22 18:20:23,046 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CPIN?(cr)
116141 2010-03-22 18:20:38,187 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CMS ERROR:
500
116141 2010-03-22 18:20:38,187 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CMS ERROR:
500(cr)
116141 2010-03-22 18:20:38,187 [WatchDog] WARN
org.smslib.helper.Logger - GTW: 353143038141132: Erroneous CPIN
response, proceeding with defaults.
116141 2010-03-22 18:20:38,187 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATE0(cr)
116344 2010-03-22 18:20:38,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
117344 2010-03-22 18:20:39,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT^CURC=0(cr)
117344 2010-03-22 18:20:39,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
117344 2010-03-22 18:20:39,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
117344 2010-03-22 18:20:39,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CLIP=1(cr)
117344 2010-03-22 18:20:39,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
117344 2010-03-22 18:20:39,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
117344 2010-03-22 18:20:39,390 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATE0(cr)
117547 2010-03-22 18:20:39,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
118547 2010-03-22 18:20:40,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CREG?(cr)
118547 2010-03-22 18:20:40,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CREG: 0,1OK
118547 2010-03-22 18:20:40,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CREG:
0,1(cr)OK(cr)
118547 2010-03-22 18:20:40,593 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: GSM: Registered to
home network.
118547 2010-03-22 18:20:40,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMEE=1(cr)
118547 2010-03-22 18:20:40,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
118547 2010-03-22 18:20:40,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
118547 2010-03-22 18:20:40,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CNMI=?(cr)
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CNMI:
(0,1,2),(0,1,2,3),(0,2),(0,1,2),(0,1)OK
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CNMI: (0,1,2),
(0,1,2,3),(0,2),(0,1,2),(0,1)(cr)OK(cr)
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 2
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 1
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 0
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 2
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 0
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT
+CNMI=2,1,0,2,0(cr)
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
118563 2010-03-22 18:20:40,609 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGF=0(cr)
118579 2010-03-22 18:20:40,625 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
118579 2010-03-22 18:20:40,625 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
>>> Gateway Status change for 353143038141132, OLD: RESTART -> NEW: STARTING
118579 2010-03-22 18:20:40,625 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
118579 2010-03-22 18:20:40,625 [WatchDog] DEBUG
org.smslib.helper.Logger - Initialized.
118579 2010-03-22 18:20:40,625 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Gateway started.
118579 2010-03-22 18:20:40,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
118579 2010-03-22 18:20:40,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMMS=2(cr)
118579 2010-03-22 18:20:40,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
118579 2010-03-22 18:20:40,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
118579 2010-03-22 18:20:40,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132:
=================================================
<< SmsSubmitPdu >>
Raw Pdu:
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D3752019
SMSC Address: [Length: 7 (07) octets, Type: 91 (10010001), Address:
639180000101]
First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-RD: (allow duplicates), TP-
VPF: (validity format, integer, TP-SRR: (No Status Report), TP-UDHI:
(no UDH)]
Message Reference: 00
Destination Address: [Length: 11 (0B), Type: 81 (10000001), Address:
09994351021]
TP-PID: 00 (00000000)
TP-DCS: 00 (7-bit GSM Alphabet) (00000000)
TP-VPF: 10584 hours
User Data Length: 42 (2A) septets
User Data (pdu) :
73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D3752019
User Data (decoded): [stress test on javelin... message count: 2]
=================================================
118579 2010-03-22 18:20:40,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Sending Pdu:
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D3752019
118579 2010-03-22 18:20:40,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGS=51(cr)
118672 2010-03-22 18:20:40,718 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
118672 2010-03-22 18:20:40,718 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
>>> Gateway Status change for 353143038141132, OLD: STARTING -> NEW: STARTED
118672 2010-03-22 18:20:40,718 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
118766 2010-03-22 18:20:40,812 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
118766 2010-03-22 18:20:40,812 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
118782 2010-03-22 18:20:40,828 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
119782 2010-03-22 18:20:41,828 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D3752019
127000 2010-03-22 18:20:49,046 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
133579 2010-03-22 18:20:55,625 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
148579 2010-03-22 18:21:10,625 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
156985 2010-03-22 18:21:19,031 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
157000 2010-03-22 18:21:19,046 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
163579 2010-03-22 18:21:25,625 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
178579 2010-03-22 18:21:40,625 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
187000 2010-03-22 18:21:49,046 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
193579 2010-03-22 18:21:55,625 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
194875 2010-03-22 18:21:56,921 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Buffer contents on
timeout: +CMS ERROR: 500
194875 2010-03-22 18:21:56,921 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT(cr)
194875 2010-03-22 18:21:56,921 [QueueManager [353143038141132]] WARN
org.smslib.helper.Logger - GTW: 353143038141132: Queue exception,
marking gateway for reset.
org.smslib.TimeoutException: No response from device.
at org.smslib.modem.AModemDriver
$CharQueue.get(AModemDriver.java:531)
at org.smslib.modem.AModemDriver.getResponse(AModemDriver.java:
329)
at
org.smslib.modem.athandler.ATHandler.sendMessage(ATHandler.java:307)
at
org.smslib.modem.ModemGateway.sendMessagePDU(ModemGateway.java:480)
at org.smslib.modem.ModemGateway.sendMessage(ModemGateway.java:
241)
at org.smslib.AGateway$QueueManager.process(AGateway.java:510)
at org.smslib.threading.AServiceThread.run(AServiceThread.java:
117)
>>> Gateway Status change for 353143038141132, OLD: STARTED -> NEW: RESTART
194875 2010-03-22 18:21:56,921 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
194875 2010-03-22 18:21:56,921 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
194875 2010-03-22 18:21:56,921 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
194875 2010-03-22 18:21:56,921 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMMS=2(cr)
194891 2010-03-22 18:21:56,937 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
194891 2010-03-22 18:21:56,937 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
194891 2010-03-22 18:21:56,937 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132:
=================================================
<< SmsSubmitPdu >>
Raw Pdu:
079136190800101011000B819099341520F10000FF17D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
SMSC Address: [Length: 7 (07) octets, Type: 91 (10010001), Address:
639180000101]
First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-RD: (allow duplicates), TP-
VPF: (validity format, integer, TP-SRR: (No Status Report), TP-UDHI:
(no UDH)]
Message Reference: 00
Destination Address: [Length: 11 (0B), Type: 81 (10000001), Address:
09994351021]
TP-PID: 00 (00000000)
TP-DCS: 00 (7-bit GSM Alphabet) (00000000)
TP-VPF: 10584 hours
User Data Length: 23 (17) septets
User Data (pdu) : D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
User Data (decoded): [Reporting modem status.]
=================================================
194891 2010-03-22 18:21:56,937 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Sending Pdu:
079136190800101011000B819099341520F10000FF17D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
194891 2010-03-22 18:21:56,937 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGS=35(cr)
194969 2010-03-22 18:21:57,015 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
194969 2010-03-22 18:21:57,015 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
195032 2010-03-22 18:21:57,078 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
195094 2010-03-22 18:21:57,140 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
195125 2010-03-22 18:21:57,171 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
195125 2010-03-22 18:21:57,171 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
196094 2010-03-22 18:21:58,140 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :
079136190800101011000B819099341520F10000FF17D232FC2DA7A7DD6750FB4D2EB741737A985E9FBB00
199875 2010-03-22 18:22:01,921 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
204875 2010-03-22 18:22:06,921 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
208579 2010-03-22 18:22:10,625 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
208579 2010-03-22 18:22:10,625 [WatchDog] WARN
org.smslib.helper.Logger - Gateway: 353143038141132 restarting.
208579 2010-03-22 18:22:10,625 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Stopping gateway...
>>> Gateway Status change for 353143038141132, OLD: RESTART -> NEW: STOPPING
208579 2010-03-22 18:22:10,625 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Stopped.
208579 2010-03-22 18:22:10,625 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
208579 2010-03-22 18:22:10,625 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - Stopped.
208579 2010-03-22 18:22:10,625 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - Stopped.
208579 2010-03-22 18:22:10,625 [SMSLib-AsyncNotifier :
353143038141132] DEBUG org.smslib.helper.Logger - GTW:
353143038141132: AsyncNotifier thread ended.
208579 2010-03-22 18:22:10,625 [SMSLib-AsyncMessageProcessor :
353143038141132] DEBUG org.smslib.helper.Logger - GTW:
353143038141132: AsyncMessageProcessor thread ended.
208579 2010-03-22 18:22:10,625 [SMSlib-ModemReader-353143038141132]
DEBUG org.smslib.helper.Logger - GTW: 353143038141132: ModemReader
thread ended.
208672 2010-03-22 18:22:10,718 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
208672 2010-03-22 18:22:10,718 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
>>> Gateway Status change for 353143038141132, OLD: STOPPING -> NEW: STOPPED
208672 2010-03-22 18:22:10,718 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
208766 2010-03-22 18:22:10,812 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Closing: COM42 @9600
208766 2010-03-22 18:22:10,812 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Gateway stopped.
208766 2010-03-22 18:22:10,812 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Starting gateway,
using Huawei (Generic) AT Handler.
208782 2010-03-22 18:22:10,828 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
208782 2010-03-22 18:22:10,828 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
>>> Gateway Status change for 353143038141132, OLD: STOPPED -> NEW: RESTART
208782 2010-03-22 18:22:10,828 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
208875 2010-03-22 18:22:10,921 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
208875 2010-03-22 18:22:10,921 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
241094 2010-03-22 18:22:43,140 [Timer-2] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Buffer contents on
timeout:
241094 2010-03-22 18:22:43,140 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Opening: COM42 @9600
241094 2010-03-22 18:22:43,140 [Timer-2] WARN
org.smslib.helper.Logger - sendMessage(): Gateway 353143038141132
does not respond, marking for restart.
>>> Gateway Status change for 353143038141132, OLD: RESTART -> NEW: RESTART
241094 2010-03-22 18:22:43,140 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
241110 2010-03-22 18:22:43,156 [WatchDog] DEBUG
org.smslib.helper.Logger - Initialized.
241110 2010-03-22 18:22:43,156 [WatchDog] DEBUG
org.smslib.helper.Logger - Initialized.
241110 2010-03-22 18:22:43,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: ModemReader thread
started.
241110 2010-03-22 18:22:43,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: AsyncNotifier thread
started.
241110 2010-03-22 18:22:43,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132:
AsyncMessageProcessor thread started.
241110 2010-03-22 18:22:43,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
241110 2010-03-22 18:22:43,156 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
241110 2010-03-22 18:22:43,156 [KeepAlive [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
241204 2010-03-22 18:22:43,250 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
241204 2010-03-22 18:22:43,250 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
242110 2010-03-22 18:22:44,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :(27)
242313 2010-03-22 18:22:44,359 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :+++
242500 2010-03-22 18:22:44,546 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATZ(cr)
242704 2010-03-22 18:22:44,750 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
243704 2010-03-22 18:22:45,750 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATZ(cr)
243907 2010-03-22 18:22:45,953 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATE0(cr)
244110 2010-03-22 18:22:46,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
245110 2010-03-22 18:22:47,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CPIN?(cr)
245110 2010-03-22 18:22:47,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CPIN: READY
245110 2010-03-22 18:22:47,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CPIN:
READY(cr)
245110 2010-03-22 18:22:47,156 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATE0(cr)
245313 2010-03-22 18:22:47,359 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
246313 2010-03-22 18:22:48,359 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT^CURC=0(cr)
246313 2010-03-22 18:22:48,359 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
246313 2010-03-22 18:22:48,359 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
246313 2010-03-22 18:22:48,359 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CLIP=1(cr)
246329 2010-03-22 18:22:48,375 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
246329 2010-03-22 18:22:48,375 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
246329 2010-03-22 18:22:48,375 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :ATE0(cr)
246532 2010-03-22 18:22:48,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
247532 2010-03-22 18:22:49,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CREG?(cr)
247532 2010-03-22 18:22:49,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CREG: 0,1OK
247532 2010-03-22 18:22:49,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CREG:
0,1(cr)OK(cr)
247532 2010-03-22 18:22:49,578 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: GSM: Registered to
home network.
247532 2010-03-22 18:22:49,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMEE=1(cr)
247532 2010-03-22 18:22:49,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
247532 2010-03-22 18:22:49,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
247532 2010-03-22 18:22:49,578 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CNMI=?(cr)
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CNMI:
(0,1,2),(0,1,2,3),(0,2),(0,1,2),(0,1)OK
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CNMI: (0,1,2),
(0,1,2,3),(0,2),(0,1,2),(0,1)(cr)OK(cr)
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 2
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 1
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 0
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 2
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - CNMI: Found best match: 0
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT
+CNMI=2,1,0,2,0(cr)
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGF=0(cr)
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
>>> Gateway Status change for 353143038141132, OLD: RESTART -> NEW: STARTING
247547 2010-03-22 18:22:49,593 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
247547 2010-03-22 18:22:49,593 [WatchDog] DEBUG
org.smslib.helper.Logger - Initialized.
247547 2010-03-22 18:22:49,593 [WatchDog] INFO
org.smslib.helper.Logger - GTW: 353143038141132: Gateway started.
247547 2010-03-22 18:22:49,593 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - Running...
247547 2010-03-22 18:22:49,593 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMMS=2(cr)
247563 2010-03-22 18:22:49,609 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: OK
247563 2010-03-22 18:22:49,609 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :OK(cr)
247563 2010-03-22 18:22:49,609 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132:
=================================================
<< SmsSubmitPdu >>
Raw Pdu:
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
SMSC Address: [Length: 7 (07) octets, Type: 91 (10010001), Address:
639180000101]
First Octet: 11 [TP-MTI: (SMS-SUBMIT), TP-RD: (allow duplicates), TP-
VPF: (validity format, integer, TP-SRR: (No Status Report), TP-UDHI:
(no UDH)]
Message Reference: 00
Destination Address: [Length: 11 (0B), Type: 81 (10000001), Address:
09994351021]
TP-PID: 00 (00000000)
TP-DCS: 00 (7-bit GSM Alphabet) (00000000)
TP-VPF: 10584 hours
User Data Length: 42 (2A) septets
User Data (pdu) :
73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
User Data (decoded): [stress test on javelin... message count: 1]
=================================================
247563 2010-03-22 18:22:49,609 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: Sending Pdu:
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
247563 2010-03-22 18:22:49,609 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGS=51(cr)
247657 2010-03-22 18:22:49,703 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
247657 2010-03-22 18:22:49,703 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
>>> Gateway Status change for 353143038141132, OLD: STARTING -> NEW: STARTED
247657 2010-03-22 18:22:49,703 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager end...
247750 2010-03-22 18:22:49,796 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - Running...
247750 2010-03-22 18:22:49,796 [NotifyQueueManager] DEBUG
org.smslib.helper.Logger - NotifyQueueManager running...
247766 2010-03-22 18:22:49,812 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
248766 2010-03-22 18:22:50,812 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :
079136190800101011000B819099341520F10000FF2A73BABC3C9F83E8E5391DF47683D4617B999D76BB5C2E50BB3C9F87CF65D0F85D77D375A018
262547 2010-03-22 18:23:04,593 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
271110 2010-03-22 18:23:13,156 [CNMIEmulatorProcessor
[353143038141132]] DEBUG org.smslib.helper.Logger - ** disabled **
274000 2010-03-22 18:23:16,046 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: BUFFER: +CMS ERROR:
500
274000 2010-03-22 18:23:16,046 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: RECV :+CMS ERROR:
500(cr)
274000 2010-03-22 18:23:16,046 [QueueManager [353143038141132]] WARN
org.smslib.helper.Logger - GTW: 353143038141132: CMS Error 500:
Retrying...
277000 2010-03-22 18:23:19,046 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: SEND :AT+CMGS=51(cr)
277204 2010-03-22 18:23:19,250 [QueueManager [353143038141132]] DEBUG
org.smslib.helper.Logger - GTW: 353143038141132: clearBuffer()
called.
277547 2010-03-22 18:23:19,593 [WatchDog] DEBUG
org.smslib.helper.Logger - Running...
Hope someone can help me with this problem. Any ideas would be much
appreciated.
Thanks! : )
--
You received this message because you are subscribed to the Google Groups
"SMSLib User 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.
