Closed GoogleCodeExporter closed 9 years ago
SendMessages log: (acturally the port is used by this program until I press
ctrl-c)
624 2012-02-15 22:16:33,071 [Thread-3] DEBUG org.smslib.threading.AServiceThr
ead - Initialized.
624 2012-02-15 22:16:33,071 [KeepAlive [modem.com1]] DEBUG org.smslib.threadi
ng.AServiceThread - Running...
624 2012-02-15 22:16:33,071 [Thread-3] DEBUG org.smslib.modem.AModemDriver$Mo
demReader - GTW: modem.com1: ModemReader thread started.
624 2012-02-15 22:16:33,071 [CNMIEmulatorProcessor [modem.com1]] DEBUG org.sm
slib.threading.AServiceThread - ** disabled **
640 2012-02-15 22:16:33,087 [Thread-3] DEBUG org.smslib.modem.AModemDriver$As
yncNotifier - GTW: modem.com1: AsyncNotifier thread started.
640 2012-02-15 22:16:33,087 [Thread-3] DEBUG org.smslib.modem.AModemDriver$As
yncMessageProcessor - GTW: modem.com1: AsyncMessageProcessor thread started.
640 2012-02-15 22:16:33,087 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: clearBuffer() called.
1654 2012-02-15 22:16:34,101 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :(27)
1857 2012-02-15 22:16:34,304 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :+++
2059 2012-02-15 22:16:34,506 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :ATZ(cr)
2262 2012-02-15 22:16:34,709 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: clearBuffer() called.
3276 2012-02-15 22:16:35,723 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :ATZ(cr)
3479 2012-02-15 22:16:35,926 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :ATE0(cr)
3682 2012-02-15 22:16:36,129 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: clearBuffer() called.
4696 2012-02-15 22:16:37,143 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CPIN?(cr)
4696 2012-02-15 22:16:37,143 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: BUFFER: +CPIN: READY
4696 2012-02-15 22:16:37,143 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :+CPIN: READY(cr)
4711 2012-02-15 22:16:37,158 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :ATE0(cr)
4914 2012-02-15 22:16:37,361 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: clearBuffer() called.
5928 2012-02-15 22:16:38,375 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CLIP=1(cr)
5928 2012-02-15 22:16:38,375 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: BUFFER: OK
5928 2012-02-15 22:16:38,375 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :OK(cr)
5928 2012-02-15 22:16:38,375 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+COPS=0(cr)
5959 2012-02-15 22:16:38,406 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: BUFFER: OK
5975 2012-02-15 22:16:38,422 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :OK(cr)
5975 2012-02-15 22:16:38,422 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :ATE0(cr)
6178 2012-02-15 22:16:38,625 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: clearBuffer() called.
7192 2012-02-15 22:16:39,639 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CREG=1(cr)
7192 2012-02-15 22:16:39,639 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: BUFFER: OK
7192 2012-02-15 22:16:39,639 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :OK(cr)
7192 2012-02-15 22:16:39,639 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CREG?(cr)
7207 2012-02-15 22:16:39,654 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
OKREG: 1,1m.com1: BUFFER: +CREG: 1
7207 2012-02-15 22:16:39,654 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :+CREG: 1(cr)+CREG: 1,1(cr)OK(cr)
7223 2012-02-15 22:16:39,670 [Thread-3] INFO org.smslib.modem.AModemDriver -
GTW: modem.com1: GSM: Registered to home network.
7223 2012-02-15 22:16:39,670 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CMEE=1(cr)
7223 2012-02-15 22:16:39,670 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: BUFFER: OK
7223 2012-02-15 22:16:39,670 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :OK(cr)
7239 2012-02-15 22:16:39,686 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CPMS=?(cr)
7239 2012-02-15 22:16:39,686 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
OKTW: modem.com1: BUFFER: +CPMS: (("SM","BM","SR"),("SM"))
7254 2012-02-15 22:16:39,701 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :+CPMS: (("SM","BM","SR"),("SM"))(cr)OK(cr)
7254 2012-02-15 22:16:39,701 [Thread-3] INFO org.smslib.modem.AModemDriver -
GTW: modem.com1: MEM: Storage Locations Found: SMBMSR
7254 2012-02-15 22:16:39,701 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CNMI=?(cr)
7270 2012-02-15 22:16:39,717 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
OKTW: modem.com1: BUFFER: +CNMI: (0-3),(0-3),(0-3),(0-2),(0,1)
7270 2012-02-15 22:16:39,717 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :+CNMI: (0-3),(0-3),(0-3),(0-2),(0,1)(cr)OK(cr)
7270 2012-02-15 22:16:39,717 [Thread-3] DEBUG org.smslib.modem.CNMIDetector -
CNMI: Found best match: 3
7270 2012-02-15 22:16:39,717 [Thread-3] DEBUG org.smslib.modem.CNMIDetector -
CNMI: Found best match: 1
7285 2012-02-15 22:16:39,732 [Thread-3] DEBUG org.smslib.modem.CNMIDetector -
CNMI: Found best match: 0
7285 2012-02-15 22:16:39,732 [Thread-3] DEBUG org.smslib.modem.CNMIDetector -
CNMI: Found best match: 2
7285 2012-02-15 22:16:39,732 [Thread-3] DEBUG org.smslib.modem.CNMIDetector -
CNMI: Found best match: 0
7285 2012-02-15 22:16:39,732 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CNMI=3,1,0,2,0(cr)
7410 2012-02-15 22:16:39,857 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: BUFFER: OK
7426 2012-02-15 22:16:39,873 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :OK(cr)
7426 2012-02-15 22:16:39,873 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: SEND :AT+CMGF=0(cr)
7426 2012-02-15 22:16:39,873 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: BUFFER: OK
7426 2012-02-15 22:16:39,873 [Thread-3] DEBUG org.smslib.modem.AModemDriver -
GTW: modem.com1: RECV :OK(cr)
7441 2012-02-15 22:16:39,888 [NotifyQueueManager] DEBUG org.smslib.notify.Noti
fyQueueManager$NotificationQueueManager - NotifyQueueManager end...
7441 2012-02-15 22:16:39,888 [Thread-3] DEBUG org.smslib.threading.AServiceThr
ead - Initialized.
7441 2012-02-15 22:16:39,888 [Thread-3] INFO org.smslib.modem.ModemGateway -
GTW: modem.com1: Gateway started.
7441 2012-02-15 22:16:39,888 [QueueManager [modem.com1]] DEBUG org.smslib.thre
ading.AServiceThread - Running...
7551 2012-02-15 22:16:39,998 [NotifyQueueManager] DEBUG org.smslib.threading.A
ServiceThread - Running...
7551 2012-02-15 22:16:39,998 [NotifyQueueManager] DEBUG org.smslib.notify.Noti
fyQueueManager$NotificationQueueManager - NotifyQueueManager running...
7551 2012-02-15 22:16:39,998 [NotifyQueueManager] DEBUG org.smslib.notify.Noti
fyQueueManager$NotificationQueueManager - NotifyQueueManager end...
7660 2012-02-15 22:16:40,107 [NotifyQueueManager] DEBUG org.smslib.threading.A
ServiceThread - Running...
7660 2012-02-15 22:16:40,107 [NotifyQueueManager] DEBUG org.smslib.notify.Noti
fyQueueManager$NotificationQueueManager - NotifyQueueManager running...
8175 2012-02-15 22:16:40,622 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: SEND :AT+CPMS="SM"(cr)
8175 2012-02-15 22:16:40,622 [main] DEBUG org.smslib.modem.AModemDriver - GTW
OKmodem.com1: BUFFER: +CPMS: 7,70,7,70
8175 2012-02-15 22:16:40,622 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: RECV :+CPMS: 7,70,7,70(cr)OK(cr)
8190 2012-02-15 22:16:40,637 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: SEND :AT+CMGL=4(cr)
10156 2012-02-15 22:16:42,603 [main] DEBUG org.smslib.modem.AModemDriver - GTW
0891683108100005F011AD108121251093057034780008FF1A62114E5F57284ED98E2A5403541700
0891683108100005F011AE108121251093057034780008FF1860E065B0897F8857535753E3002C4E
0891683108100005F011B00B813119011075F50008FF124F1F4F26003500310032606D501954044F
OK
10171 2012-02-15 22:16:42,618 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: RECV :+CMGL: 8,2,,28(cr)0891683108100005F011FF10812125109305703478
FF08FF0C8FD86CA1523054620020003F(cr)+CMGL: 9,2,,28(cr)0891683108100005F011FF1081
2125109305703478FF08FF0C8FD86CA1523054620020003F(cr)+CMGL: 10,3,,28(cr)089168310
8100005F011AC108121251093057034780008FF0C8FD86CA1523054620020003F(cr)+CMGL: 13,3
,,42(cr)0891683108100005F011AD108121251093057034780008FF1A62114E5F57284ED98E2A54
035417003F6765768453CA4E0D003F(cr)+CMGL: 16,3,,40(cr)0891683108100005F011AE10812
1251093057034780008FF1860E065B0897F8857535753E3002C4E9A8FD0675196448FD1(cr)+CMGL
: 18,3,,30(cr)0891683108100005F011AF108121251093057034780008FF0E4E9453F77EBF5230
4E1C56DB4E86(cr)+CMGL: 26,3,,32(cr)0891683108100005F011B00B813119011075F50008FF1
24F1F4F26003500310032606D501954044F4D(cr)OK(cr)
10171 2012-02-15 22:16:42,618 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: READ PDU: 0891683108100005F011FF10812125109305703478FF08FF0C8FD86C
A1523054620020003F
10187 2012-02-15 22:16:42,634 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: READ PDU: 0891683108100005F011FF10812125109305703478FF08FF0C8FD86C
A1523054620020003F
10187 2012-02-15 22:16:42,634 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: READ PDU: 0891683108100005F011AC108121251093057034780008FF0C8FD86C
A1523054620020003F
10187 2012-02-15 22:16:42,634 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: READ PDU: 0891683108100005F011AD108121251093057034780008FF1A62114E
5F57284ED98E2A54035417003F6765768453CA4E0D003F
10187 2012-02-15 22:16:42,634 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: READ PDU: 0891683108100005F011AE108121251093057034780008FF1860E065
B0897F8857535753E3002C4E9A8FD0675196448FD1
10187 2012-02-15 22:16:42,634 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: READ PDU: 0891683108100005F011AF108121251093057034780008FF0E4E9453
F77EBF52304E1C56DB4E86
10187 2012-02-15 22:16:42,634 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: READ PDU: 0891683108100005F011B00B813119011075F50008FF124F1F4F2600
3500310032606D501954044F4D
10203 2012-02-15 22:16:42,650 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: SEND :AT+CPMS="BM"(cr)
10203 2012-02-15 22:16:42,650 [main] DEBUG org.smslib.modem.AModemDriver - GTW
OKmodem.com1: BUFFER: +CPMS: 0,20,7,70
10203 2012-02-15 22:16:42,650 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: RECV :+CPMS: 0,20,7,70(cr)OK(cr)
10203 2012-02-15 22:16:42,650 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: SEND :AT+CMGL=4(cr)
10218 2012-02-15 22:16:42,665 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: BUFFER: OK
10218 2012-02-15 22:16:42,665 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: RECV :OK(cr)
10218 2012-02-15 22:16:42,665 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: SEND :AT+CPMS="SR"(cr)
10234 2012-02-15 22:16:42,681 [main] DEBUG org.smslib.modem.AModemDriver - GTW
OKmodem.com1: BUFFER: +CPMS: 0,70,7,70
10234 2012-02-15 22:16:42,681 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: RECV :+CPMS: 0,70,7,70(cr)OK(cr)
10234 2012-02-15 22:16:42,681 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: SEND :AT+CMGL=4(cr)
10234 2012-02-15 22:16:42,681 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: BUFFER: OK
10234 2012-02-15 22:16:42,681 [main] DEBUG org.smslib.modem.AModemDriver - GTW
: modem.com1: RECV :OK(cr)
10249 2012-02-15 22:16:42,696 [main] DEBUG org.smslib.modem.ModemGateway - GTW
: modem.com1: CheckMpMsgList(): MAINLIST: 0
10249 2012-02-15 22:16:42,696 [DelayQueueManager] DEBUG org.smslib.queues.Abstr
actQueueManager$DelayQueueManager - DelayQueueManager end...
10452 2012-02-15 22:16:42,899 [WatchDog] DEBUG org.smslib.threading.AServiceThr
ead - Stopped.
10452 2012-02-15 22:16:42,899 [main] INFO org.smslib.modem.ModemGateway - GTW
: modem.com1: Stopping gateway...
10452 2012-02-15 22:16:42,899 [QueueManager [modem.com1]] DEBUG org.smslib.thre
ading.AServiceThread - Stopped.
10452 2012-02-15 22:16:42,899 [NotifyQueueManager] DEBUG org.smslib.notify.Noti
fyQueueManager$NotificationQueueManager - NotifyQueueManager end...
10452 2012-02-15 22:16:42,899 [KeepAlive [modem.com1]] DEBUG org.smslib.threadi
ng.AServiceThread - Stopped.
10452 2012-02-15 22:16:42,899 [CNMIEmulatorProcessor [modem.com1]] DEBUG org.sm
slib.threading.AServiceThread - Stopped.
10452 2012-02-15 22:16:42,899 [SMSLib-AsyncNotifier : modem.com1] DEBUG org.sms
lib.modem.AModemDriver$AsyncNotifier - GTW: modem.com1: AsyncNotifier thread en
ded.
10452 2012-02-15 22:16:42,899 [SMSLib-AsyncMessageProcessor : modem.com1] DEBUG
org.smslib.modem.AModemDriver$AsyncMessageProcessor - GTW: modem.com1: AsyncMe
ssageProcessor thread ended.
10452 2012-02-15 22:16:42,899 [SMSlib-ModemReader-modem.com1] DEBUG org.smslib.
modem.AModemDriver$ModemReader - GTW: modem.com1: ModemReader thread ended.
10452 2012-02-15 22:16:42,899 [main] INFO org.smslib.modem.SerialModemDriver
- GTW: modem.com1: Closing: COM6 @115200
10452 2012-02-15 22:16:42,899 [main] INFO org.smslib.modem.ModemGateway - GTW
: modem.com1: Gateway stopped.
10561 2012-02-15 22:16:43,008 [NotifyQueueManager] DEBUG org.smslib.threading.A
ServiceThread - Running...
10561 2012-02-15 22:16:43,008 [NotifyQueueManager] DEBUG org.smslib.notify.Noti
fyQueueManager$NotificationQueueManager - NotifyQueueManager running...
10561 2012-02-15 22:16:43,008 [NotifyQueueManager] DEBUG org.smslib.notify.Noti
fyQueueManager$NotificationQueueManager - NotifyQueueManager end...
10655 2012-02-15 22:16:43,102 [NotifyQueueManager] DEBUG org.smslib.threading.A
ServiceThread - Stopped.
Press any key to restart....
14898 2012-02-15 22:16:47,345 [main] INFO org.smslib.queues.DefaultQueueManage
r - Queue directory not defined. Queued messages will not be saved to filesyste
m.
14898 2012-02-15 22:16:47,345 [main] DEBUG org.smslib.threading.AServiceThread
- Initialized.
14898 2012-02-15 22:16:47,345 [main] DEBUG org.smslib.threading.AServiceThread
- Initialized.
14898 2012-02-15 22:16:47,345 [DelayQueueManager] DEBUG org.smslib.threading.AS
erviceThread - Running...
14898 2012-02-15 22:16:47,345 [DelayQueueManager] DEBUG org.smslib.queues.Abstr
actQueueManager$DelayQueueManager - DelayQueueManager running...
14898 2012-02-15 22:16:47,345 [Thread-12] INFO org.smslib.modem.ModemGateway
- GTW: modem.com1: Starting gateway, using Generic AT Handler.
14898 2012-02-15 22:16:47,345 [Thread-12] INFO org.smslib.modem.SerialModemDri
ver - GTW: modem.com1: Opening: COM6 @115200
14898 2012-02-15 22:16:47,345 [WatchDog] DEBUG org.smslib.threading.AServiceThr
ead - Running...
16926 2012-02-15 22:16:49,373 [Thread-12] INFO org.smslib.modem.SerialModemDri
ver - GTW: modem.com1: Closing: COM6 @115200
17940 2012-02-15 22:16:50,387 [DelayQueueManager] DEBUG org.smslib.queues.Abstr
actQueueManager$DelayQueueManager - DelayQueueManager end...
18143 2012-02-15 22:16:50,590 [WatchDog] DEBUG org.smslib.threading.AServiceThr
ead - Stopped.
18143 2012-02-15 22:16:50,590 [main] INFO org.smslib.modem.ModemGateway - GTW
: modem.com1: Stopping gateway...
18143 2012-02-15 22:16:50,590 [main] INFO org.smslib.modem.SerialModemDriver
- GTW: modem.com1: Closing: COM6 @115200
18143 2012-02-15 22:16:50,590 [main] INFO org.smslib.modem.ModemGateway - GTW
: modem.com1: Gateway stopped.
org.smslib.GatewayException: Comm library exception: java.lang.RuntimeException:
javax.comm.PortInUseException: Port currently owned by Unknown Windows Applicat
ion
at org.smslib.modem.SerialModemDriver.connectPort(SerialModemDriver.java
:102)
at org.smslib.modem.AModemDriver.connect(AModemDriver.java:114)
at org.smslib.modem.ModemGateway.startGateway(ModemGateway.java:189)
at org.smslib.Service$1Starter.run(Service.java:276)
23213 2012-02-15 22:16:55,660 [main] INFO org.smslib.modem.ModemGateway - GTW
: modem.com1: Stopping gateway...
23213 2012-02-15 22:16:55,660 [main] INFO org.smslib.modem.SerialModemDriver
- GTW: modem.com1: Closing: COM6 @115200
23213 2012-02-15 22:16:55,660 [main] INFO org.smslib.modem.ModemGateway - GTW
: modem.com1: Gateway stopped.
Original comment by ycwe...@gmail.com
on 15 Feb 2012 at 2:36
[deleted comment]
You can't run SMSServer and SendMessages at the same time. What you see is very
logical - they both compete for the same serial port.
Original comment by T.Delenikas
on 16 Feb 2012 at 3:16
I don't run them at the same time. Attach all logs here just for convenience.
when running example.modem.ReadMessages, after "Press any key to restart....",
PortInUseException was thrown.
when running SMSServer, about 10-15minutes later, PortInUseException was thrown.
Original comment by ycwe...@gmail.com
on 16 Feb 2012 at 3:31
Are you using a USB Connection?
Do you have any phone related application installed (like Nokia PC Suite, etc)?
Original comment by T.Delenikas
on 18 Feb 2012 at 4:51
yes, I'm using a USB connection (using a USB-to-Serial Connector to connect my
laptop and a serial gsm modem).
Maybe it's usb issue. Yesterday, I changed to use serial port directly, and it
runs smoothly.
So I think it's not a program issue, pls close it. Thanks a lot.
Original comment by ycwe...@gmail.com
on 21 Feb 2012 at 12:54
Hi,
Good to hear this is working :)
If you can avoid USB converters, please do so! They sometimes create so much
trouble that will drive you crazy...
Have fun.
Original comment by T.Delenikas
on 22 Feb 2012 at 9:09
Original issue reported on code.google.com by
ycwe...@gmail.com
on 15 Feb 2012 at 2:34Attachments: