Lots of Error - 3E4 - in SMSDEBUG.LOG and slow sms | Search |
NowSMS Support Forums ⬆ NowSMS Support - SMS Issues ⬆ |
◄ ► |
Author | Message | |||
Christoffer New member Username: Chx Post Number: 1 Registered: 10-2020 |
Hi I am in the process of moving from a server with Now SMS/MMS Gateway v2010.02.09 to a new server with Now SMS/MMS Gateway v2020.01.15 After a test move of 1 modem (COM8), i notice it is slow when sending sms messages and i see lots of errors (timouts?) in the SMSDEBUG.LOG file. Everything seems to work, but all the errors is worrisome. Below is a snipppit of the errors, and they repeat forever. How can i find the cause of this? I don't get it on the old server. Ps. the new server is running trial license, so 30 sms/min limit, but i only get about 5sms/min. I have bought the new license, but the bigger limit is great for finding the limit of the system, so it is not entered yet. 12:42:47:017 [20] ModemTest: COM8: 12:42:50:870 [20] ModemTest: OK 12:42:52:359 [20] ReceiveModemCommand: Error - 3E4 - 12:42:52:359 [20] ReceiveModemCommand: CancelIo 12:42:52:359 [20] ReceiveModemCommand: After CancelIo #1 12:42:52:359 [20] ReceiveModemCommand: After CancelIo #1a 12:43:07:360 [20] ReceiveModemCommand: After CancelIo #2 12:43:07:360 [20] ReceiveModemCommand: After CancelIo #3 12:43:13:112 [20] ReceiveModemCommand: Error - 3E4 - 12:43:13:112 [20] ReceiveModemCommand: CancelIo 12:43:13:112 [20] ReceiveModemCommand: After CancelIo #1 12:43:13:112 [20] ReceiveModemCommand: After CancelIo #1a 12:43:28:113 [20] ReceiveModemCommand: After CancelIo #2 12:43:28:113 [20] ReceiveModemCommand: After CancelIo #3 12:43:33:865 [20] ReceiveModemCommand: Error - 3E4 - 12:43:33:865 [20] ReceiveModemCommand: CancelIo 12:43:33:865 [20] ReceiveModemCommand: After CancelIo #1 12:43:33:865 [20] ReceiveModemCommand: After CancelIo #1a 12:43:48:866 [20] ReceiveModemCommand: After CancelIo #2 12:43:48:866 [20] ReceiveModemCommand: After CancelIo #3 12:43:54:627 [20] ReceiveModemCommand: Error - 3E4 - 12:43:54:627 [20] ReceiveModemCommand: CancelIo 12:43:54:627 [20] ReceiveModemCommand: After CancelIo #1 12:43:54:627 [20] ReceiveModemCommand: After CancelIo #1a 12:44:09:627 [20] ReceiveModemCommand: After CancelIo #2 12:44:09:627 [20] ReceiveModemCommand: After CancelIo #3 12:44:15:396 [20] ReceiveModemCommand: Error - 3E4 - 12:44:15:396 [20] ReceiveModemCommand: CancelIo 12:44:15:396 [20] ReceiveModemCommand: After CancelIo #1 12:44:15:396 [20] ReceiveModemCommand: After CancelIo #1a 12:44:30:397 [20] ReceiveModemCommand: After CancelIo #2 12:44:30:397 [20] ReceiveModemCommand: After CancelIo #3 12:44:36:157 [20] ReceiveModemCommand: Error - 3E4 - 12:44:36:157 [20] ReceiveModemCommand: CancelIo 12:44:36:157 [20] ReceiveModemCommand: After CancelIo #1 12:44:36:157 [20] ReceiveModemCommand: After CancelIo #1a 12:44:51:157 [20] ReceiveModemCommand: After CancelIo #2 12:44:51:157 [20] ReceiveModemCommand: After CancelIo #3 12:44:56:918 [20] ReceiveModemCommand: Error - 3E4 - 12:44:56:918 [20] ReceiveModemCommand: CancelIo 12:44:56:918 [20] ReceiveModemCommand: After CancelIo #1 12:44:56:918 [20] ReceiveModemCommand: After CancelIo #1a 12:45:11:919 [20] ReceiveModemCommand: After CancelIo #2 12:45:11:919 [20] ReceiveModemCommand: After CancelIo #3 12:45:17:673 [20] ReceiveModemCommand: Error - 3E4 - 12:45:17:673 [20] ReceiveModemCommand: CancelIo 12:45:17:673 [20] ReceiveModemCommand: After CancelIo #1 12:45:17:673 [20] ReceiveModemCommand: After CancelIo #1a 12:45:32:673 [20] ReceiveModemCommand: After CancelIo #2 12:45:32:673 [20] ReceiveModemCommand: After CancelIo #3 12:45:38:479 [20] ReceiveModemCommand: Error - 3E4 - 12:45:38:479 [20] ReceiveModemCommand: CancelIo 12:45:38:479 [20] ReceiveModemCommand: After CancelIo #1 12:45:38:479 [20] ReceiveModemCommand: After CancelIo #1a 12:45:53:480 [20] ReceiveModemCommand: After CancelIo #2 12:45:53:480 [20] ReceiveModemCommand: After CancelIo #3 12:45:57:745 [20] ModemTest: COM8: 12:46:01:355 [20] ModemTest: OK 12:46:02:850 [20] ReceiveModemCommand: Error - 3E4 - 12:46:02:850 [20] ReceiveModemCommand: CancelIo 12:46:02:850 [20] ReceiveModemCommand: After CancelIo #1 12:46:02:850 [20] ReceiveModemCommand: After CancelIo #1a 12:46:17:850 [20] ReceiveModemCommand: After CancelIo #2 12:46:17:850 [20] ReceiveModemCommand: After CancelIo #3 | |||
Bryce Norwood - NowSMS Support Board Administrator Username: Bryce Post Number: 8357 Registered: 10-2002 |
Hi, This is very strange. We have seen this error before, but not with this type of repeating pattern. I'd like to get a better idea of what is going on between NowSMS and the modem. Please edit SMSGW.INI, and under the [SMSGW] header, add DebugModemPoll=Yes This will add extra debug information to the log. Every 2 or 3 seconds, NowSMS is polling the modem, looking for received messages, and something about this activity is generating these errors. I'd like to see the SMSDEBUG.LOG with that setting. Either post a log snippet in reply here or e-mail to nowsms@nowsms.com, and put Attention: Bryce in the subject line of the email. Regards, Bryce Norwood NowSMS Support | |||
Christoffer New member Username: Chx Post Number: 2 Registered: 10-2020 |
08:59:48:707 [0] UseRouteCache: Yes 08:59:50:754 [0] main: Before InitStatCounters 08:59:50:754 [0] main: After InitStatCounters 08:59:50:754 [0] main: IPV6 Disabled 08:59:58:317 [0] main: Before CheckDatabaseIntegrity 08:59:58:317 [0] main: After CheckDatabaseIntegrity 09:00:03:333 [0] main: Now SMS/MMS Gateway v2020.01.15 Web server started on port number 8800 09:00:03:336 [13] ThreadScanAlerts: Before CheckDatabaseIntegrity 09:00:03:336 [13] ThreadScanAlerts: After CheckDatabaseIntegrity 09:00:03:337 [0] main: 17 Days remaining in trial version 09:00:03:341 [20] ThreadProcessModem: COM8: 09:00:03:341 [20] ThreadProcessModem: Before ModemAllocate - COM8: 09:00:03:342 [20] ThreadProcessModem: After ModemAllocate - COM8: - OK 09:00:03:342 [20] ThreadProcessModem: Re-initializing modem: COM8: ... 09:00:04:346 [0] UseRouteCache: Yes 09:00:04:823 [20] ReceiveModemCommand: Error - 3E4 - 09:00:04:823 [20] ReceiveModemCommand: CancelIo 09:00:04:823 [20] ReceiveModemCommand: After CancelIo #1 09:00:04:823 [20] ReceiveModemCommand: After CancelIo #1a 09:00:19:824 [20] ReceiveModemCommand: After CancelIo #2 09:00:19:824 [20] ReceiveModemCommand: After CancelIo #3 09:00:20:412 [20] TestModemSpeed: Initialised modem at 115200 bps 09:00:22:396 [20] ThreadProcessModem: ATI0 09:00:22:396 [20] ThreadProcessModem: Sierra Wireless WMP50 Product OK 09:00:22:781 [20] ThreadProcessModem: ATI1 09:00:22:781 [20] ThreadProcessModem: OK 09:00:23:164 [20] ThreadProcessModem: ATI2 09:00:23:164 [20] ThreadProcessModem: OK 09:00:23:544 [20] ThreadProcessModem: ATI3 09:00:23:544 [20] ThreadProcessModem: R7.45.1.201105250600.WMP50 2203572 052511 06:00 OK 09:00:23:927 [20] ThreadProcessModem: ATI4 09:00:23:927 [20] ThreadProcessModem: Q:0 V:1 S0:000 S2:043 S3:013 S4:010 S5:008 +CR:0 +CRC:0 +CMEE:1 +CBST:0,0,1 +SPEAKER:1 +ECHO:0 &C:1 &D:2 %C:0 +IPR:0 +ICF:3,4 +IFC:2,2 OK 09:00:24:310 [20] ThreadProcessModem: ATI5 09:00:24:310 [20] ThreadProcessModem: Q:0 V:1 S0:000 S2:043 S3:013 S4:010 S5:008 +CR:0 +CRC:0 +CMEE:0 +CBST:0,0,1 +SPEAKER:1 +ECHO:0 &C:1 &D:2 %C:0 +IPR:0 +ICF:3,4 +IFC:2,2 OK 09:00:26:229 [20] ModemTest: COM8: 09:00:30:311 [20] ModemTest: OK 09:00:30:311 [20] ThreadProcessModem: AT+CPMS? 09:00:30:917 [20] ThreadProcessModem: +CPMS: "ME",0,99,"SM",0,20,"SM",0,20 OK 09:00:30:917 [20] ThreadProcessModem: AT+CNMI=2,2,2,1,0 09:00:32:011 [20] ThreadProcessModem: OK 09:00:32:011 [20] ThreadProcessModem: AT+CNMI? 09:00:32:616 [20] ThreadProcessModem: +CNMI: 2,2,2,1,0 OK 09:00:32:616 [20] ThreadProcessModem: AT+CNMI? 09:00:33:221 [20] ThreadProcessModem: +CNMI: 2,2,2,1,0 OK 09:00:33:221 [20] ThreadProcessModem: AT+CPMS=? 09:00:33:880 [20] ThreadProcessModem: +CPMS: (("SM","ME","BM","SR"),("SM","ME"),("SM","ME")) OK 09:00:33:880 [20] ThreadProcessModem: AT+CPMS="SM","SM","SM" 09:00:35:266 [20] ThreadProcessModem: +CPMS: 0,20,0,20,0,20 OK 09:00:35:266 [20] ThreadProcessModem: AT+CPMS? 09:00:35:870 [20] ThreadProcessModem: +CPMS: "SM",0,20,"SM",0,20,"SM",0,20 OK 09:00:36:525 [20] ThreadProcessModem: AT+CNMI? 09:00:37:126 [20] ThreadProcessModem: +CNMI: 2,2,2,1,0 OK 09:00:37:126 [20] ThreadProcessModem: AT+CNMI=? 09:00:37:784 [20] ThreadProcessModem: +CNMI: (0-3),(0-3),(0-3),(0-2),(0,1) OK 09:00:37:784 [20] ThreadProcessModem: AT+COPS? 09:00:38:390 [20] ThreadProcessModem: +COPS: 0,2,24001 OK 09:00:38:390 [20] ThreadProcessModem: AT+CSQ 09:00:38:879 [20] ThreadProcessModem: +CSQ: 21,0 OK 09:00:38:879 [20] ThreadProcessModem: AT+CNUM 09:00:39:425 [20] ThreadProcessModem: OK 09:00:39:425 [20] ThreadProcessModem: Modem initialization complete: COM8: 09:00:39:425 [20] ModemReceiveMessages: AT+CPMS="SM" 09:00:40:249 [20] ModemReceiveMessages: +CPMS: 0,20,0,20,0,20 OK 09:00:40:249 [20] ModemReceiveMessages: AT+CMGL=0 09:00:40:907 [20] ModemReceiveMessages: OK 09:00:40:907 [20] ModemReceiveMessages: AT+CMGL=1 09:00:41:565 [20] ModemReceiveMessages: OK 09:00:41:565 [20] ModemReceiveMessages: AT+CPMS="ME" 09:00:42:395 [20] ModemReceiveMessages: +CPMS: 0,99,0,20,0,20 OK 09:00:42:395 [20] ModemReceiveMessages: AT+CMGL=0 09:00:43:052 [20] ModemReceiveMessages: OK 09:00:43:052 [20] ModemReceiveMessages: AT+CMGL=1 09:00:43:712 [20] ModemReceiveMessages: OK 09:00:45:202 [20] ReceiveModemCommand: Error - 3E4 - 09:00:45:202 [20] ReceiveModemCommand: CancelIo 09:00:45:202 [20] ReceiveModemCommand: After CancelIo #1 09:00:45:202 [20] ReceiveModemCommand: After CancelIo #1a 09:01:00:202 [20] ReceiveModemCommand: After CancelIo #2 09:01:00:202 [20] ReceiveModemCommand: After CancelIo #3 09:01:00:202 [20] ModemReceiveMessages: AT+CPMS="SM" 09:01:01:025 [20] ModemReceiveMessages: +CPMS: 0,20,0,20,0,20 OK 09:01:01:025 [20] ModemReceiveMessages: AT+CMGL=0 09:01:01:680 [20] ModemReceiveMessages: OK 09:01:01:680 [20] ModemReceiveMessages: AT+CMGL=1 09:01:02:340 [20] ModemReceiveMessages: OK 09:01:02:340 [20] ModemReceiveMessages: AT+CPMS="ME" 09:01:03:162 [20] ModemReceiveMessages: +CPMS: 0,99,0,20,0,20 OK 09:01:03:162 [20] ModemReceiveMessages: AT+CMGL=0 09:01:03:817 [20] ModemReceiveMessages: OK 09:01:03:817 [20] ModemReceiveMessages: AT+CMGL=1 09:01:04:476 [20] ModemReceiveMessages: OK 09:01:05:971 [20] ReceiveModemCommand: Error - 3E4 - 09:01:05:971 [20] ReceiveModemCommand: CancelIo 09:01:05:971 [20] ReceiveModemCommand: After CancelIo #1 09:01:05:971 [20] ReceiveModemCommand: After CancelIo #1a 09:01:20:971 [20] ReceiveModemCommand: After CancelIo #2 09:01:20:971 [20] ReceiveModemCommand: After CancelIo #3 09:01:20:971 [20] ModemReceiveMessages: AT+CPMS="SM" 09:01:21:795 [20] ModemReceiveMessages: +CPMS: 0,20,0,20,0,20 OK 09:01:21:795 [20] ModemReceiveMessages: AT+CMGL=0 09:01:22:477 [20] ModemReceiveMessages: OK 09:01:22:477 [20] ModemReceiveMessages: AT+CMGL=1 09:01:23:136 [20] ModemReceiveMessages: OK 09:01:23:136 [20] ModemReceiveMessages: AT+CPMS="ME" 09:01:23:958 [20] ModemReceiveMessages: +CPMS: 0,99,0,20,0,20 OK 09:01:23:958 [20] ModemReceiveMessages: AT+CMGL=0 09:01:24:615 [20] ModemReceiveMessages: OK 09:01:24:615 [20] ModemReceiveMessages: AT+CMGL=1 09:01:25:272 [20] ModemReceiveMessages: OK 09:01:26:766 [20] ReceiveModemCommand: Error - 3E4 - 09:01:26:766 [20] ReceiveModemCommand: CancelIo 09:01:26:766 [20] ReceiveModemCommand: After CancelIo #1 09:01:26:766 [20] ReceiveModemCommand: After CancelIo #1a 09:01:41:766 [20] ReceiveModemCommand: After CancelIo #2 09:01:41:766 [20] ReceiveModemCommand: After CancelIo #3 09:01:41:766 [20] ModemReceiveMessages: AT+CPMS="SM" 09:01:42:612 [20] ModemReceiveMessages: +CPMS: 0,20,0,20,0,20 OK 09:01:42:612 [20] ModemReceiveMessages: AT+CMGL=0 09:01:43:272 [20] ModemReceiveMessages: OK 09:01:43:272 [20] ModemReceiveMessages: AT+CMGL=1 09:01:43:930 [20] ModemReceiveMessages: OK 09:01:43:930 [20] ModemReceiveMessages: AT+CPMS="ME" 09:01:44:753 [20] ModemReceiveMessages: +CPMS: 0,99,0,20,0,20 OK 09:01:44:753 [20] ModemReceiveMessages: AT+CMGL=0 09:01:45:408 [20] ModemReceiveMessages: OK 09:01:45:408 [20] ModemReceiveMessages: AT+CMGL=1 09:01:46:065 [20] ModemReceiveMessages: OK 09:01:47:558 [20] ReceiveModemCommand: Error - 3E4 - 09:01:47:558 [20] ReceiveModemCommand: CancelIo 09:01:47:558 [20] ReceiveModemCommand: After CancelIo #1 09:01:47:558 [20] ReceiveModemCommand: After CancelIo #1a 09:02:02:558 [20] ReceiveModemCommand: After CancelIo #2 09:02:02:558 [20] ReceiveModemCommand: After CancelIo #3 09:02:02:558 [20] ModemReceiveMessages: AT+CPMS="SM" 09:02:03:382 [20] ModemReceiveMessages: +CPMS: 0,20,0,20,0,20 OK | |||
Bryce Norwood - NowSMS Support Board Administrator Username: Bryce Post Number: 8359 Registered: 10-2002 |
Very interesting. This is not what I expected. There is actually no real error occurring...just a normal situation being treated as a minor communication error, and introducing a 15 second delay. We will have an update shortly that avoids this delay. Out of curiosity, what is the Windows version? Regards, Bryce Norwood NowSMS Support | |||
Christoffer New member Username: Chx Post Number: 3 Registered: 10-2020 |
Sounds great :) The OS is Windows Server 2019 | |||
Des - NowSMS Support Board Administrator Username: Desosms Post Number: 6183 Registered: 08-2008 |
We've posted an update to fIx how this is handled. The download link is https://www.nowsms.com/download/nowsms20201015.zip -- Des NowSMS Support |