On 06 Mar 2020 at 09:24a, alter ego pondered and said...
Sent M_EOB command
Got M_NUL command args: QSIZE 0 files 0 bytes
Got M_EOB command args:
We got an M_EOB, but there are still 1 files pending M_GOT
Got M_GET command args: 5e613184.pkt 4673 1583427972 0
Error in recv() of first byte of packet header
Unlocking C:/mailer/outbound.015\00040064.bsy.
Things seem amiss all around I think. I can see NET 2 has been locked up with
a MUTIL semaphore and it seems like some duff packets that when MUTIL was trying to toss it, caused it to crash then leave the semaphore behind.
I am also having issues at NET 2 trying to poll NET 4 and send files via SSL
+ 2020.03.07 04:14:09 1-Polling 21:4/100 on slot 1 via BINKP
+ 2020.03.07 04:14:09 1-Connecting to BBS.CASTLEROCKBBS.COM on port 24553
+ 2020.03.07 04:14:10 1-Connected by IPV4 SSL to 184.155.113.241
+ 2020.03.07 04:14:10 1-S: NUL SYS fsxNet [Net2] Tholian
+ 2020.03.07 04:14:10 1-S: NUL ZYZ Todd Zieman - Solaris
+ 2020.03.07 04:14:10 1-S: NUL TIME Sat, 07 Mar 2020 04:14:10 -0500
+ 2020.03.07 04:14:10 1-S: NUL VER Mystic/1.12A46 binkp/1.0
+ 2020.03.07 04:14:10 1-S: NUL BUILD 2020/03/04 20:44:52 Windows/64
+ 2020.03.07 04:14:10 1-S: ADR 21:2/100@fsxnet
+ 2020.03.07 04:14:10 1-R: NUL OPT CRAM-MD5-86a24c5ee06dc946158936994e204396
+ 2020.03.07 04:14:10 1-R: NUL SYS fsxHUB Niba [NET4]
+ 2020.03.07 04:14:10 1-System fsxHUB Niba [NET4]
+ 2020.03.07 04:14:10 1-R: NUL ZYZ Black Panther
+ 2020.03.07 04:14:10 1-SysOp Black Panther
+ 2020.03.07 04:14:10 1-R: NUL TIME Sat, 07 Mar 2020 02:14:22 -0700
+ 2020.03.07 04:14:10 1-Info TIME Sat, 07 Mar 2020 02:14:22 -0700
+ 2020.03.07 04:14:10 1-R: NUL VER Mystic/1.12A46 binkp/1.0
+ 2020.03.07 04:14:10 1-Mailer Mystic/1.12A46 binkp/1.0
+ 2020.03.07 04:14:10 1-R: NUL BUILD 2020/03/04 20:43:32 Windows/32
+ 2020.03.07 04:14:10 1-Info BUILD 2020/03/04 20:43:32 Windows/32
+ 2020.03.07 04:14:10 1-R: ADR 21:4/100@fsxnet 21:4/0@fsxnet
+ 2020.03.07 04:14:10 1-S: PWD
+ 2020.03.07 04:14:10 1-R: OK secure
+ 2020.03.07 04:14:10 1-S: NUL QSIZE 2 files 212,354 bytes
+ 2020.03.07 04:14:10 1-Sending: fffe0000.thr (2,092 bytes)
+ 2020.03.07 04:14:10 1-S: FILE fffe0000.thr 2092 1583409482 0
+ 2020.03.07 04:14:10 1-R: NUL QSIZE 200 files 830,867 bytes
+ 2020.03.07 04:14:10 1-Remote Queue: 200 files 830,867 bytes
+ 2020.03.07 04:14:10 1-R: FILE 0315f1a9.pkt 1385 1583409297 0
+ 2020.03.07 04:14:10 1-Receiving: 0315f1a9.pkt (1,385 bytes)
+ 2020.03.07 04:14:11 1-S: GOT 0315f1a9.pkt 1385 1583409297
+ 2020.03.07 04:14:11 1-R: GET fffe0000.thr 2092 1583409482 0
+ 2020.03.07 04:14:41 1-Session timeout
+ 2020.03.07 04:14:41 1-Session ended (0 sent, 1 rcvd, 0 skip)
+ 2020.03.07 04:14:41 Polled 1 systems
Polling your HUB from NET 2 via SSL also hits a problem
--------------------- POLL v1.12 A46 2020/03/04 Sat, Mar 07 2020 (loglevel 3) + 2020.03.07 04:19:29 Poll BINKP node via address lookup: 21:3/100
+ 2020.03.07 04:19:29 Queued 1 files (199,283 bytes) for 21:3/100
+ 2020.03.07 04:19:29 1-Polling 21:3/100 on slot 1 via BINKP
+ 2020.03.07 04:19:29 1-Connecting to alterant.leenooks.net on port 24556
+ 2020.03.07 04:19:30 1-Connected by IPV4 SSL to 101.186.5.106
+ 2020.03.07 04:19:30 1-R: NUL OPT CRAM-MD5-758d6b97589c93a8cd8f9b671d64265c CRYPT
+ 2020.03.07 04:19:30 1-S: NUL SYS fsxNet [Net2] Tholian
+ 2020.03.07 04:19:30 1-S: NUL ZYZ Todd Zieman - Solaris
+ 2020.03.07 04:19:30 1-S: NUL TIME Sat, 07 Mar 2020 04:19:30 -0500
+ 2020.03.07 04:19:30 1-S: NUL VER Mystic/1.12A46 binkp/1.0
+ 2020.03.07 04:19:30 1-S: NUL BUILD 2020/03/04 20:44:52 Windows/64
+ 2020.03.07 04:19:30 1-S: ADR 21:2/100@fsxnet
+ 2020.03.07 04:19:31 1-R: NUL SYS W7-1-1
+ 2020.03.07 04:19:31 1-System W7-1-1
+ 2020.03.07 04:19:31 1-R: NUL ZYZ alterego
+ 2020.03.07 04:19:31 1-SysOp alterego
+ 2020.03.07 04:19:31 1-R: NUL LOC Parkdale VIC
+ 2020.03.07 04:19:31 1-Location Parkdale VIC
+ 2020.03.07 04:19:31 1-R: NUL NDL 115200,TCP,BINKP
+ 2020.03.07 04:19:31 1-Info NDL 115200,TCP,BINKP
+ 2020.03.07 04:19:31 1-R: NUL TIME Sat Mar 07 2020 20:19:30 GMT+1100 (AUS Eastern Daylight Time)
+ 2020.03.07 04:19:31 1-Info TIME Sat Mar 07 2020 20:19:30 GMT+1100 (AUS Eastern Daylight Time)
+ 2020.03.07 04:19:31 1-R: NUL VER BinkIT/2.28,JSBinkP/1.122,sbbs3.17c/Win32 binkp/1.1
+ 2020.03.07 04:19:31 1-Mailer BinkIT/2.28,JSBinkP/1.122,sbbs3.17c/Win32 binkp/1.1
+ 2020.03.07 04:19:31 1-R: ADR 10:1/2@private 618:510/2@micronet 516:999/998@videotex 21:3/100@fsxnet
+ 2020.03.07 04:19:31 1-S: PWD
+ 2020.03.07 04:19:31 1-R: OK secure
+ 2020.03.07 04:19:31 1-S: NUL QSIZE 1 files 199,283 bytes
+ 2020.03.07 04:19:31 1-R: EOB
+ 2020.03.07 04:19:31 1-Sending: ffff0000.sa0 (199,283 bytes)
+ 2020.03.07 04:19:32 1-S: FILE ffff0000.sa0 199283 1583572357 0
+ 2020.03.07 04:19:32 1-Connection lost
+ 2020.03.07 04:19:32 1-Session ended (0 sent, 0 rcvd, 0 skip)
+ 2020.03.07 04:19:32 Polled 1 systems
I haven't even looked at NET 4 HUB yet :(
I am not sure if this problems relate to the move to SSL or if it's to do
with the dupe flood the other day and perhaps some nodes also having issues pulling down large packets.
But certainly for BinkP sessions between NET 2 and 3 and NET 2 and 4 there's issues...
Let's try a NET 2 poll for NET 1
--------------------- POLL v1.12 A46 2020/03/04 Sat, Mar 07 2020 (loglevel 3) + 2020.03.07 04:22:15 Poll BINKP node via address lookup: 21:1/100
+ 2020.03.07 04:22:15 1-Polling 21:1/100 on slot 1 via BINKP
+ 2020.03.07 04:22:15 1-Connecting to agency.bbs.nz on port 24553
+ 2020.03.07 04:22:17 1-Connected by IPV4 SSL to 219.89.83.33
+ 2020.03.07 04:22:17 1-S: NUL SYS fsxNet [Net2] Tholian
+ 2020.03.07 04:22:17 1-S: NUL ZYZ Todd Zieman - Solaris
+ 2020.03.07 04:22:17 1-S: NUL TIME Sat, 07 Mar 2020 04:22:17 -0500
+ 2020.03.07 04:22:17 1-S: NUL VER Mystic/1.12A46 binkp/1.0
+ 2020.03.07 04:22:17 1-S: NUL BUILD 2020/03/04 20:44:52 Windows/64
+ 2020.03.07 04:22:17 1-S: ADR 21:2/100@fsxnet
+ 2020.03.07 04:22:17 1-R: NUL OPT CRAM-MD5-cfb0334f69b698598b83d084dfbde02f
+ 2020.03.07 04:22:17 1-R: NUL SYS fsxHUB Risa [NET1]
+ 2020.03.07 04:22:17 1-System fsxHUB Risa [NET1]
+ 2020.03.07 04:22:17 1-R: NUL ZYZ Avon
+ 2020.03.07 04:22:17 1-SysOp Avon
+ 2020.03.07 04:22:17 1-R: NUL TIME Sat, 07 Mar 2020 22:22:05 +1300
+ 2020.03.07 04:22:17 1-Info TIME Sat, 07 Mar 2020 22:22:05 +1300
+ 2020.03.07 04:22:17 1-R: NUL VER Mystic/1.12A46 binkp/1.0
+ 2020.03.07 04:22:17 1-Mailer Mystic/1.12A46 binkp/1.0
+ 2020.03.07 04:22:17 1-R: NUL BUILD 2020/03/06 14:53:11 Windows/32
+ 2020.03.07 04:22:17 1-Info BUILD 2020/03/06 14:53:11 Windows/32
+ 2020.03.07 04:22:17 1-R: ADR 21:1/100@fsxnet 21:1/3@fsxnet 21:1/2@fsxnet 21:1/0@fsxnet 21:0/0@fsxnet
+ 2020.03.07 04:22:17 1-S: PWD
+ 2020.03.07 04:22:18 1-R: OK secure
+ 2020.03.07 04:22:18 1-S: NUL QSIZE 0 files 0 bytes
+ 2020.03.07 04:22:18 1-S: EOB
+ 2020.03.07 04:22:18 1-R: NUL QSIZE 1 files 2,414 bytes
+ 2020.03.07 04:22:18 1-Remote Queue: 1 files 2,414 bytes
+ 2020.03.07 04:22:18 1-R: FILE ffff0000.sav 2414 1583572504 0
+ 2020.03.07 04:22:18 1-Receiving: ffff0000.sav (2,414 bytes)
+ 2020.03.07 04:22:18 1-S: GOT ffff0000.sav 2414 1583572504
+ 2020.03.07 04:22:19 1-R: EOB
+ 2020.03.07 04:22:19 1-Session ended (0 sent, 1 rcvd, 0 skip)
+ 2020.03.07 04:22:19 Polled 1 systems
That worked.
I am going to look at NET 4 next and may revert all HUBS to just non SSL
links until we can suss this.
--- Mystic BBS v1.12 A46 2020/03/04 (Windows/32)
* Origin: Agency BBS | Dunedin, New Zealand | agency.bbs.nz (21:1/101)