1. Forum
  2. Fsxnet Message
  3. FSX MYS

  • Pre-alphas updated

    From g00r00@21:1/108 to All on Friday, November 03, 2017 13:05:58
    I've updated the pre-alphas for those who want to test cutting edge code.

    www.mysticbbs.com/downloads/prealpha/

    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: Sector 7 [Mystic BBS WHQ] (21:1/108)
  • From deepthaw@21:2/136 to g00r00 on Friday, November 03, 2017 13:38:04
    On 11/03/17, g00r00 said the following...

    I've updated the pre-alphas for those who want to test cutting edge code.

    Didn't see anything new in the whatsnew.txt - anything to look out for?

    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: Deep Space '94 * telnet://deepspace94.com * fnord (21:2/136)
  • From Avon@21:1/101 to g00r00 on Saturday, November 04, 2017 09:19:36
    On 11/03/17, g00r00 pondered and said...

    I've updated the pre-alphas for those who want to test cutting edge code.


    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: Sector 7 [Mystic BBS WHQ] (21:1/108)

    Thanks :)

    I have updated 1/100 HUB and Agency at 1/101

    Am enjoying the extra data output during a fidopoll connection :)

    Something is amiss however. I can see a session within my computer between Fidopoll and MIS not working... I see garbage in the exchange, fidopoll move
    on the MIS BinkP sit with the connection open until it times out 20 secs approx. later

    Sample logging for A36/1103 is attached.

    HUB fidopoll

    [snip]

    Nov 04 09:14:58 Connected
    Nov 04 09:14:59 System Agency BBS
    Nov 04 09:14:59 SysOp Avon
    Nov 04 09:14:59 Mailer Mystic/1.12A36 binkp/1.0
    Nov 04 09:14:59 Sending: 0293f72d.pkt (43,144 bytes)
    Nov 04 09:15:31 Session timeout
    Nov 04 09:15:31 Session complete (0 sent, 0 rcvd, 0 skip)

    [snip]


    Agency BinkP

    [snip]



    Nov 04 09:14:58 1 Authorization State: 0 HH:0 NH:1
    Nov 04 09:14:58 1 Sent: NUL OPT CRAM-MD5-d75ce999ddf0a25d3e5113d132bacba8
    Nov 04 09:14:58 1 Recv: NUL SYS fsxHUB [fsxNet WHQ]
    Nov 04 09:14:58 1 Authorization State: 1 HH:1 NH:0
    Nov 04 09:14:58 1 SYS fsxHUB [fsxNet WHQ]
    Nov 04 09:14:58 1 Sent: NUL SYS Agency BBS
    Nov 04 09:14:58 1 Sent: NUL ZYZ Avon
    Nov 04 09:14:58 1 Sent: NUL VER Mystic/1.12A36 binkp/1.0
    Nov 04 09:14:58 1 Sent: ADR 46:3/203@agoranet 39:970/1@amiganet 3:770/100@fidonet 24:400/100@sportnet 21:1/101@fsxnet 44:100/14@dorenet
    Nov 04 09:14:58 1 Recv: NUL ZYZ Paul Hayton
    Nov 04 09:14:58 1 Authorization State: 3 HH:1 NH:0
    Nov 04 09:14:58 1 ZYZ Paul Hayton
    Nov 04 09:14:58 1 Recv: NUL VER Mystic/1.12A36 binkp/1.0
    Nov 04 09:14:58 1 VER Mystic/1.12A36 binkp/1.0
    Nov 04 09:14:58 1 Recv: ADR 21:1/100@fsxnet 21:1/3@fsxnet 21:1/2@fsxnet 21:1/0@fsxnet 21:0/0@fsxnet
    Nov 04 09:14:58 1 ADR 21:1/100@fsxnet 21:1/3@fsxnet 21:1/2@fsxnet
    21:1/0@fsxnet 21:0/0@fsxnet
    Nov 04 09:14:59 1 Authorization State: 4 HH:0 NH:1
    Nov 04 09:14:59 1 Recv: PWD CRAM-MD5-4407d2567eba0d195c4675c8b0430092
    Nov 04 09:14:59 1 Authorization State: 4 HH:1 NH:0
    Nov 04 09:14:59 1 Received PWD frame
    Nov 04 09:14:59 1 Remote: MD5=1 AKA=21:1/100@fsxnet 21:1/3@fsxnet
    21:1/2@fsxnet 21:1/0@fsxnet 21:0/0@fsxnet
    Nov 04 09:14:59 1 Looking for matching AKA in EchoNodes
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 No match in clients address list for 3:770/1@fidonet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 No match in clients address list for 46:3/103@agoranet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 No match in clients address list for 39:970/0@amiganet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 No match in clients address list for 24:400/1@sportnet
    Nov 04 09:14:59 1 Match=TRUE EchoNode:21:1/100@fsxnet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Authenticating 21:1/100@fsxnet by CRAM-MD5
    Nov 04 09:14:59 1 Password accepted
    Nov 04 09:14:59 1 Sent: OK secure
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Match=TRUE EchoNode:21:1/100@fsxnet Remote:21:1/100@fsxnet
    Nov 04 09:14:59 1 Queuing for 21:1/100@fsxnet by CRAM-MD5
    Nov 04 09:14:59 1 Password accepted
    Nov 04 09:14:59 1 Queued 0 files for 21:1/100
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/3@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/2@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:0/0@fsxnet
    Nov 04 09:14:59 1 State RxS:1 TxS:1 HH:0 NH:1
    Nov 04 09:14:59 1 Sent: EOB
    Nov 04 09:14:59 1 State RxS:1 TxS:4 HH:0 NH:1
    Nov 04 09:14:59 1 Recv: FILE 0293f72d.pkt 43144 1509786116 0
    Nov 04 09:14:59 1 State RxS:1 TxS:4 HH:1 NH:0
    Nov 04 09:14:59 1 File exists [sizeB=43144 sizeF=0] [dateB=1264863292 dateF=1264863292]
    Nov 04 09:14:59 1 Sent: GET 0293f72d.pkt 43144 1509786116 0
    Nov 04 09:14:59 1 Resuming file at offset 0
    Nov 04 09:14:59 1 Receiving 0293f72d.pkt (43,144 bytes)
    Nov 04 09:14:59 1 Recv: -~
    l{j-=-ld'\cQkkbal0e.N b
    Nov 04 09:14:59 1 State RxS:2 TxS:4 HH:1 NH:0
    Nov 04 09:15:59 1 Session timeout
    Nov 04 09:15:59 1 Session complete (0 sent, 0 rcvd, 0 skip)

    [snip]

    I am going to keep running the latest alpha code at 1/101 and 1/100 but drop the last known working Fidopoll back in.Which I think is the A35 one... as I type this I am not convinced many nodes are getting their echomail etc. when
    I poll them.

    Best, Paul

    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: Agency BBS | telnet://agency.bbs.geek.nz (21:1/101)
  • From Avon@21:1/101 to g00r00 on Saturday, November 04, 2017 09:40:48
    OK I ended up having to roll back both 1/100 and 1/101 to the last version of A36 that I was using prior to updating to the first one with the date added
    to the tearline.

    What I saw happening were issues with the new fidopoll timing out when connecting with the new MIS from the same release. I then rolled my fidopoll back to the version I am using now and tested again with the updated MIS and saw the same issues so rolled all binaries back to the pre updated tearline version.... doing this at both the HUB and Agency.

    Something was amiss, and I needed to jump back else folks would not be able
    to communicate.

    Best, Paul

    --- Mystic BBS v1.12 A36 (Windows/32)
    * Origin: Agency BBS | telnet://agency.bbs.geek.nz (21:1/101)
  • From g00r00@21:1/108 to deepthaw on Friday, November 03, 2017 18:25:24
    Didn't see anything new in the whatsnew.txt - anything to look out for?

    The whatsnew has everything.

    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: Sector 7 [Mystic BBS WHQ] (21:1/108)
  • From g00r00@21:1/108 to Avon on Friday, November 03, 2017 18:27:39
    OK I ended up having to roll back both 1/100 and 1/101 to the last
    version of A36 that I was using prior to updating to the first one with the date added to the tearline.

    I don't think I did anything with BINKP in this release from the very last
    one. Odd. It's been running here the entire time with no issues so far, but I'll keep an eye out I guess?

    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: Sector 7 [Mystic BBS WHQ] (21:1/108)
  • From dream master@21:1/163 to g00r00 on Friday, November 03, 2017 14:48:19
    On 11/03/17, g00r00 said the following...
    I've updated the pre-alphas for those who want to test cutting edge code. www.mysticbbs.com/downloads/prealpha/

    thank you will check it out later and see the new magic ;)

    |08 .|05|13|15Dr|07e|08am Ma|07st|15er|13|05|08.
    |08 |05|13 |13|05|08
    |11 DoRE|03!|11ACiDiC|03!|11Demonic |08[|15dreamland|09.|15darktech|09.|15org|08]

    --- Mystic BBS v1.12 A36 (Windows/64)
    * Origin: |08--[|15!|07dreamland BBS dreamland.darktech.org (21:1/163)
  • From Skuz@21:1/105 to g00r00 on Friday, November 03, 2017 21:35:51
    On 11/03/17, g00r00 said the following...

    I've updated the pre-alphas for those who want to test cutting edge code. www.mysticbbs.com/downloads/prealpha/
    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)

    Sweet, by my count this is the 3rd pre-alpha.. testing build date (:

    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: flupH | fluph.darktech.org (21:1/105)
  • From Avon@21:1/101 to g00r00 on Saturday, November 04, 2017 16:18:10
    On 11/03/17, g00r00 pondered and said...


    I don't think I did anything with BINKP in this release from the very
    last one. Odd. It's been running here the entire time with no issues
    so far, but I'll keep an eye out I guess?

    It was strange, this behavior was just observed internally polling one copy
    of mystic from another within the same computer using different ports.

    I'm not sure.. if I can set up some test systems I'll try to repro

    --- Mystic BBS v1.12 A36 (Windows/32)
    * Origin: Agency BBS | telnet://agency.bbs.geek.nz (21:1/101)
  • From g00r00@21:1/108 to Avon on Saturday, November 04, 2017 03:38:31
    It was strange, this behavior was just observed internally polling one copy of mystic from another within the same computer using different ports.

    I'm not sure.. if I can set up some test systems I'll try to repro

    If you notice anything or find a way to make it happen regularly let me know.

    So far with my (somewhat limited) testing, I haven't been able to break anything here with MIS2 or FidoPoll, not even with IREX and many files!

    I spent all of my Friday evening working on the events in MIS2! Almost done!

    --- Mystic BBS v1.12 A36 2017/11/03 (Windows/32)
    * Origin: Sector 7 [Mystic BBS WHQ] (21:1/108)
  • From Avon@21:1/101 to g00r00 on Saturday, November 04, 2017 22:17:53
    On 11/04/17, g00r00 pondered and said...

    If you notice anything or find a way to make it happen regularly let me know.

    So far with my (somewhat limited) testing, I haven't been able to break anything here with MIS2 or FidoPoll, not even with IREX and many files!


    To be honest I've been a bit time poor today so have not created further test systems and I can see now there's a even newer shiny update with events - thanks! - so I will get some sleep and tomorrow start over and see how we go etc.

    I spent all of my Friday evening working on the events in MIS2! Almost done!

    What are top effort - well done sir!

    Best, Paul

    --- Mystic BBS v1.12 A36 (Windows/32)
    * Origin: Agency BBS | telnet://agency.bbs.geek.nz (21:1/101)
  • From Avon@21:1/101 to g00r00 on Sunday, November 05, 2017 20:27:52
    On 11/04/17, g00r00 pondered and said...

    I'm not sure.. if I can set up some test systems I'll try to repro

    If you notice anything or find a way to make it happen regularly let me know.

    For most of today 1/100 has not been able to poll 1/101.

    When the latest updated Fidopoll connects to the earlier version of A36 MIS there are timeout errors.

    Latest Fidopoll at HUB

    [snip]

    Nov 05 20:07:58 FIDOPOLL Version 1.12 A36
    Nov 05 20:07:58 Scanning 21:1/101
    Nov 05 20:07:58 Queued 46 files (215557 bytes) to 21:1/101
    Nov 05 20:07:58 Polling BINKP node 21:1/101
    Nov 05 20:07:58 Connecting to XXX.XXX.XXX.XXX:24555 <--redacted
    Nov 05 20:07:58 Connected
    Nov 05 20:07:59 System Agency BBS
    Nov 05 20:07:59 SysOp Avon
    Nov 05 20:07:59 Mailer Mystic/1.12A36 binkp/1.0
    Nov 05 20:07:59 Sending: 030ba84c.pkt (31,093 bytes)
    Nov 05 20:08:29 Session timeout
    Nov 05 20:08:29 Session complete (0 sent, 0 rcvd, 0 skip)

    [snip]

    On Agency MIS

    [snip]

    Nov 05 20:07:58 1 Authorization State: 0 HH:0 NH:1
    Nov 05 20:07:58 1 Sent: NUL OPT CRAM-MD5-5b6daad7123d7c5ebe2c9868b456190f
    Nov 05 20:07:58 1 Recv: NUL SYS fsxHUB [fsxNet WHQ]
    Nov 05 20:07:58 1 Authorization State: 1 HH:1 NH:0
    Nov 05 20:07:58 1 SYS fsxHUB [fsxNet WHQ]
    Nov 05 20:07:58 1 Sent: NUL SYS Agency BBS
    Nov 05 20:07:58 1 Sent: NUL ZYZ Avon
    Nov 05 20:07:58 1 Sent: NUL VER Mystic/1.12A36 binkp/1.0
    Nov 05 20:07:58 1 Sent: ADR 46:3/203@agoranet 39:970/1@amiganet 3:770/100@fidonet 24:400/100@sportnet 21:1/101@fsxnet 44:100/14@dorenet
    Nov 05 20:07:58 1 Recv: NUL ZYZ Paul Hayton
    Nov 05 20:07:58 1 Authorization State: 3 HH:1 NH:0
    Nov 05 20:07:58 1 ZYZ Paul Hayton
    Nov 05 20:07:58 1 Recv: NUL VER Mystic/1.12A36 binkp/1.0
    Nov 05 20:07:58 1 VER Mystic/1.12A36 binkp/1.0
    Nov 05 20:07:58 1 Recv: ADR 21:1/100@fsxnet 21:1/3@fsxnet 21:1/2@fsxnet 21:1/0@fsxnet 21:0/0@fsxnet
    Nov 05 20:07:58 1 ADR 21:1/100@fsxnet 21:1/3@fsxnet 21:1/2@fsxnet
    21:1/0@fsxnet 21:0/0@fsxnet
    Nov 05 20:07:59 1 Authorization State: 4 HH:0 NH:1
    Nov 05 20:07:59 1 Recv: PWD CRAM-MD5-61dc549c59335c8b8193d03751abef7f
    Nov 05 20:07:59 1 Authorization State: 4 HH:1 NH:0
    Nov 05 20:07:59 1 Received PWD frame
    Nov 05 20:07:59 1 Remote: MD5=1 AKA=21:1/100@fsxnet 21:1/3@fsxnet
    21:1/2@fsxnet 21:1/0@fsxnet 21:0/0@fsxnet
    Nov 05 20:07:59 1 Looking for matching AKA in EchoNodes
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 No match in clients address list for 3:770/1@fidonet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 No match in clients address list for 46:3/103@agoranet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 No match in clients address list for 39:970/0@amiganet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 No match in clients address list for 24:400/1@sportnet
    Nov 05 20:07:59 1 Match=TRUE EchoNode:21:1/100@fsxnet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Authenticating 21:1/100@fsxnet by CRAM-MD5
    Nov 05 20:07:59 1 Password accepted
    Nov 05 20:07:59 1 Sent: OK secure
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Match=TRUE EchoNode:21:1/100@fsxnet Remote:21:1/100@fsxnet
    Nov 05 20:07:59 1 Queuing for 21:1/100@fsxnet by CRAM-MD5
    Nov 05 20:07:59 1 Password accepted
    Nov 05 20:07:59 1 Queued 0 files for 21:1/100
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/3@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/2@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:3:770/1@fidonet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:46:3/103@agoranet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:39:970/0@amiganet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:24:400/1@sportnet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:44:100/0@dorenet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:0/0@fsxnet
    Nov 05 20:07:59 1 State RxS:1 TxS:1 HH:0 NH:1
    Nov 05 20:07:59 1 Sent: EOB
    Nov 05 20:07:59 1 State RxS:1 TxS:4 HH:0 NH:1
    Nov 05 20:07:59 1 Recv: FILE 030ba84c.pkt 31093 1509850958 0
    Nov 05 20:07:59 1 State RxS:1 TxS:4 HH:1 NH:0
    Nov 05 20:07:59 1 Receiving 030ba84c.pkt (31,093 bytes)
    Nov 05 20:07:59 1 Recv: Data 31,093/892,416,288
    Nov 05 20:07:59 1 State RxS:2 TxS:4 HH:1 NH:0
    Nov 05 20:07:59 1 Received Rx Data 892416288
    Nov 05 20:08:29 1 Invalid data frame
    Nov 05 20:08:29 1 Recv: Data 1/10,416
    Nov 05 20:08:29 1 Remote disconnect
    Nov 05 20:08:29 1 Session complete (0 sent, 0 rcvd, 0 skip)

    [snip]

    I see in the Agency echomail\in directory a 0kb packet file trying to be sent from the HUB. If I remove this and re-poll from the HUB the same issue
    occurs. I have saved the packet.

    [time passes]

    I then set up the MIS2 running BinkP for IPv4 only for Agency - this is the same 'earlier' version of A36 that I was using for MIS that had issues above with latest Fidopoll.

    I then forced a Fidopoll from 1/100 to 1/101

    Hub Fidopoll

    [snip]

    Nov 05 20:22:06 FIDOPOLL Version 1.12 A36
    Nov 05 20:22:06 Scanning 21:1/101
    Nov 05 20:22:06 Queued 46 files (215557 bytes) to 21:1/101
    Nov 05 20:22:06 Polling BINKP node 21:1/101
    Nov 05 20:22:06 Connecting to XXX.XXX.XXX.XXX:24555
    Nov 05 20:22:06 Connected
    Nov 05 20:22:06 System Agency BBS
    Nov 05 20:22:06 SysOp Avon
    Nov 05 20:22:06 Mailer Mystic/1.12A36 binkp/1.0
    Nov 05 20:22:06 Sending: 030ba84c.pkt (31,093 bytes)
    Nov 05 20:22:07 Sending: 031123a8.pkt (2,125 bytes)
    Nov 05 20:22:07 Sending: 03125145.pkt (2,378 bytes)
    Nov 05 20:22:07 Sending: 0314e0ba.pkt (1,183 bytes)
    Nov 05 20:22:08 Sending: 03158599.pkt (2,516 bytes)
    Nov 05 20:22:08 Sending: 0315e215.pkt (1,345 bytes)
    Nov 05 20:22:09 Sending: 03163e94.pkt (1,276 bytes)
    Nov 05 20:22:09 Sending: 0316970a.pkt (1,807 bytes)
    Nov 05 20:22:10 Sending: 03197aee.pkt (1,532 bytes)
    Nov 05 20:22:10 Sending: 031cf132.pkt (2,443 bytes)
    Nov 05 20:22:11 Sending: 031ff2f8.pkt (2,685 bytes)
    Nov 05 20:22:11 Sending: 03239bdb.pkt (2,074 bytes)
    Nov 05 20:22:12 Sending: 0323f859.pkt (1,405 bytes)
    Nov 05 20:22:12 Sending: 03255a2f.pkt (1,444 bytes)
    Nov 05 20:22:12 Sending: 0329a7f9.pkt (2,924 bytes)
    Nov 05 20:22:13 Sending: 032c6fb3.pkt (40,110 bytes)
    Nov 05 20:22:43 Socket read error 10054
    Nov 05 20:22:43 Socket read error 10054
    Nov 05 20:22:43 Socket read error 10054
    Nov 05 20:22:43 Error receiving data (Socket read buffer error 10054 size=0/2256
    Nov 05 20:22:43 Remote disconnect
    Nov 05 20:22:43 Session complete (15 sent, 0 rcvd, 0 skip)

    [snip]

    So a few more were sent including the file that had seemingly held up the transfers using MIS but still there were issues and an eventual timeout reported at 1/101 ...

    Agency BinkP MIS2

    [snip]

    ---------- Mystic v1.12 A36 Sun, Nov 05 2017 (loglevel 3)
    + 20:21:30 MANAGER Starting 1 server(s)
    + 20:21:30 BINKP Listening on IPV4 port 24555 using interface "0.0.0.0"
    + 20:22:06 BINKP Connect on slot 1/5
    + 20:22:06 BINKP 1-Addr: XXX.XXX.XXX.XXX
    + 20:22:06 BINKP 1-Host: AGENCY
    + 20:22:06 BINKP 1-Authorization State: 0 HH:0 NH:1
    + 20:22:06 BINKP 1-Sent: NUL OPT CRAM-MD5-5c5505aac6a3de4c2c8bbec7449d6a50
    + 20:22:06 BINKP 1-Recv: NUL SYS fsxHUB [fsxNet WHQ]
    + 20:22:06 BINKP 1-Authorization State: 1 HH:1 NH:0
    + 20:22:06 BINKP 1-System: fsxHUB [fsxNet WHQ]
    + 20:22:06 BINKP 1-Sent: NUL SYS Agency BBS
    + 20:22:06 BINKP 1-Sent: NUL ZYZ Avon
    + 20:22:06 BINKP 1-Sent: NUL VER Mystic/1.12A36 binkp/1.0
    + 20:22:06 BINKP 1-Sent: ADR 46:3/203@agoranet 39:970/1@amiganet 3:770/100@fidonet 24:400/100@sportnet 21:1/101@fsxnet 44:100/14@dorenet
    + 20:22:06 BINKP 1-Recv: NUL ZYZ Paul Hayton
    + 20:22:06 BINKP 1-Authorization State: 3 HH:1 NH:0
    + 20:22:06 BINKP 1-Info: ZYZ Paul Hayton
    + 20:22:06 BINKP 1-Recv: NUL VER Mystic/1.12A36 binkp/1.0
    + 20:22:06 BINKP 1-Recv: ADR 21:1/100@fsxnet 21:1/3@fsxnet 21:1/2@fsxnet 21:1/0@fsxnet 21:0/0@fsxnet
    + 20:22:06 BINKP 1-Recv: PWD CRAM-MD5-cc5bb476954c00da652e026cd23d3bd9
    + 20:22:06 BINKP 1-Authorization State: 4 HH:1 NH:0
    + 20:22:06 BINKP 1-Received PWD frame
    + 20:22:06 BINKP 1-Remote: MD5=1 AKA=21:1/100@fsxnet 21:1/3@fsxnet 21:1/2@fsxnet 21:1/0@fsxnet 21:0/0@fsxnet
    + 20:22:06 BINKP 1-Looking for matching AKA in EchoNodes
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-No match in clients address list for 3:770/1@fidonet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-No match in clients address list for 46:3/103@agoranet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-No match in clients address list for 39:970/0@amiganet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-No match in clients address list for 24:400/1@sportnet
    + 20:22:06 BINKP 1-Match=TRUE EchoNode:21:1/100@fsxnet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Authenticating 21:1/100@fsxnet by CRAM-MD5
    + 20:22:06 BINKP 1-Sent: OK secure
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=TRUE EchoNode:21:1/100@fsxnet Remote:21:1/100@fsxnet
    + 20:22:06 BINKP 1-Queued 0 files for 21:1/100@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/3@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/2@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:44:100/0@dorenet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:1/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:3:770/1@fidonet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:46:3/103@agoranet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:39:970/0@amiganet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:24:400/1@sportnet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/100@fsxnet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:44:100/0@dorenet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-Match=FALSE EchoNode:21:1/10@fsxnet Remote:21:0/0@fsxnet
    + 20:22:06 BINKP 1-State RxS:WaitFile TxS:NextFile HH:0 NH:1
    + 20:22:06 BINKP 1-Sent: EOB
    + 20:22:06 BINKP 1-Recv: FILE 030ba84c.pkt 31093 1509850958 0
    + 20:22:06 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:06 BINKP 1-File exists [Remote size=31093 Local size=31093] [Remote date=1264916563 Local date=1264951834]
    + 20:22:06 BINKP 1-Renaming file 030ba84c.pkt to 030ba84c.1.pkt
    + 20:22:06 BINKP 1-Receiving: 030ba84c.1.pkt (31,093 bytes)
    + 20:22:06 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:06 BINKP 1-Received: 31,093 of 31,093
    + 20:22:06 BINKP 1-Sent: GOT 030ba84c.pkt 31093 1509850958
    + 20:22:07 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:07 BINKP 1-Recv: FILE 031123a8.pkt 2125 1509854550 0
    + 20:22:07 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:07 BINKP 1-Receiving: 031123a8.pkt (2,125 bytes)
    + 20:22:07 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:07 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:07 BINKP 1-Received: 2,125 of 2,125
    + 20:22:07 BINKP 1-Sent: GOT 031123a8.pkt 2125 1509854550
    + 20:22:07 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:07 BINKP 1-Recv: FILE 03125145.pkt 2378 1509855322 0
    + 20:22:07 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:07 BINKP 1-Receiving: 03125145.pkt (2,378 bytes)
    + 20:22:07 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:07 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:07 BINKP 1-Received: 2,378 of 2,378
    + 20:22:07 BINKP 1-Sent: GOT 03125145.pkt 2378 1509855322
    + 20:22:07 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:07 BINKP 1-Recv: FILE 0314e0ba.pkt 1183 1509857000 0
    + 20:22:07 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:07 BINKP 1-Receiving: 0314e0ba.pkt (1,183 bytes)
    + 20:22:08 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:08 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:08 BINKP 1-Received: 1,183 of 1,183
    + 20:22:08 BINKP 1-Sent: GOT 0314e0ba.pkt 1183 1509857000
    + 20:22:08 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:08 BINKP 1-Recv: FILE 03158599.pkt 2516 1509857422 0
    + 20:22:08 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:08 BINKP 1-Receiving: 03158599.pkt (2,516 bytes)
    + 20:22:08 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:08 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:08 BINKP 1-Received: 2,516 of 2,516
    + 20:22:08 BINKP 1-Sent: GOT 03158599.pkt 2516 1509857422
    + 20:22:08 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:08 BINKP 1-Recv: FILE 0315e215.pkt 1345 1509857658 0
    + 20:22:08 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:08 BINKP 1-Receiving: 0315e215.pkt (1,345 bytes)
    + 20:22:08 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:08 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:08 BINKP 1-Received: 1,345 of 1,345
    + 20:22:08 BINKP 1-Sent: GOT 0315e215.pkt 1345 1509857658
    + 20:22:09 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:09 BINKP 1-Recv: FILE 03163e94.pkt 1276 1509857896 0
    + 20:22:09 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:09 BINKP 1-Receiving: 03163e94.pkt (1,276 bytes)
    + 20:22:09 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:09 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:09 BINKP 1-Received: 1,276 of 1,276
    + 20:22:09 BINKP 1-Sent: GOT 03163e94.pkt 1276 1509857896
    + 20:22:09 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:09 BINKP 1-Recv: FILE 0316970a.pkt 1807 1509858122 0
    + 20:22:09 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:09 BINKP 1-Receiving: 0316970a.pkt (1,807 bytes)
    + 20:22:09 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:09 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:09 BINKP 1-Received: 1,807 of 1,807
    + 20:22:09 BINKP 1-Sent: GOT 0316970a.pkt 1807 1509858122
    + 20:22:09 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:10 BINKP 1-Recv: FILE 03197aee.pkt 1532 1509860016 0
    + 20:22:10 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:10 BINKP 1-Receiving: 03197aee.pkt (1,532 bytes)
    + 20:22:10 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:10 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:10 BINKP 1-Received: 1,532 of 1,532
    + 20:22:10 BINKP 1-Sent: GOT 03197aee.pkt 1532 1509860016
    + 20:22:10 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:10 BINKP 1-Recv: FILE 031cf132.pkt 2443 1509862286 0
    + 20:22:10 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:10 BINKP 1-Receiving: 031cf132.pkt (2,443 bytes)
    + 20:22:10 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:10 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:10 BINKP 1-Received: 2,443 of 2,443
    + 20:22:10 BINKP 1-Sent: GOT 031cf132.pkt 2443 1509862286
    + 20:22:10 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:11 BINKP 1-Recv: FILE 031ff2f8.pkt 2685 1509864256 0
    + 20:22:11 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:11 BINKP 1-Receiving: 031ff2f8.pkt (2,685 bytes)
    + 20:22:11 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:11 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:11 BINKP 1-Received: 2,685 of 2,685
    + 20:22:11 BINKP 1-Sent: GOT 031ff2f8.pkt 2685 1509864256
    + 20:22:11 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:11 BINKP 1-Recv: FILE 03239bdb.pkt 2074 1509866654 0
    + 20:22:11 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:11 BINKP 1-Receiving: 03239bdb.pkt (2,074 bytes)
    + 20:22:11 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:11 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:11 BINKP 1-Received: 2,074 of 2,074
    + 20:22:11 BINKP 1-Sent: GOT 03239bdb.pkt 2074 1509866654
    + 20:22:11 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:12 BINKP 1-Recv: FILE 0323f859.pkt 1405 1509866890 0
    + 20:22:12 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:12 BINKP 1-Receiving: 0323f859.pkt (1,405 bytes)
    + 20:22:12 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:12 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:12 BINKP 1-Received: 1,405 of 1,405
    + 20:22:12 BINKP 1-Sent: GOT 0323f859.pkt 1405 1509866890
    + 20:22:12 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:12 BINKP 1-Recv: FILE 03255a2f.pkt 1444 1509867796 0
    + 20:22:12 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:12 BINKP 1-Receiving: 03255a2f.pkt (1,444 bytes)
    + 20:22:12 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:12 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:12 BINKP 1-Received: 1,444 of 1,444
    + 20:22:12 BINKP 1-Sent: GOT 03255a2f.pkt 1444 1509867796
    + 20:22:12 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:12 BINKP 1-Recv: FILE 0329a7f9.pkt 2924 1509870618 0
    + 20:22:12 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:12 BINKP 1-Receiving: 0329a7f9.pkt (2,924 bytes)
    + 20:22:12 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:12 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:12 BINKP 1-Received: 2,924 of 2,924
    + 20:22:12 BINKP 1-Sent: GOT 0329a7f9.pkt 2924 1509870618
    + 20:22:13 BINKP 1-State RxS:WaitFile TxS:Done HH:0 NH:1
    + 20:22:13 BINKP 1-Recv: FILE 032c6fb3.pkt 40110 1509872440 0
    + 20:22:13 BINKP 1-State RxS:WaitFile TxS:Done HH:1 NH:0
    + 20:22:13 BINKP 1-Receiving: 032c6fb3.pkt (40,110 bytes)
    + 20:22:13 BINKP 1-State RxS:GetData TxS:Done HH:0 NH:1
    + 20:22:13 BINKP 1-GetDataStr size mismatch. Expected:-1 Actual:0
    + 20:22:13 BINKP 1-Recv:
    + 20:22:13 BINKP 1-State RxS:GetData TxS:Done HH:1 NH:0
    + 20:22:43 BINKP 1-Session timeout
    + 20:22:43 BINKP 1-Session complete (0 sent, 15 rcvd, 0 skip)

    [snip]

    I will now update Agency to the same version of Mystic the HUB is currently using and see if 1/100 Fidopoll will send the remaining packets across to
    1/101 without issues..

    More to follow..

    Best, Paul

    --- Mystic BBS v1.12 A36 (Windows/32)
    * Origin: Agency BBS | telnet://agency.bbs.geek.nz (21:1/101)
  • From Avon@21:1/101 to g00r00 on Sunday, November 05, 2017 21:02:47
    On 11/05/17, Avon pondered and said...

    I will now update Agency to the same version of Mystic the HUB is currently using and see if 1/100 Fidopoll will send the remaining
    packets across to 1/101 without issues..

    More to follow..

    I updated to the latest version (I think :) check the tag line) at 1/101 and tied polling MIS2 at 1/101 again from 1/100

    HUB Fidopoll

    [snip]

    Nov 05 20:37:11 FIDOPOLL Version 1.12 A36
    Nov 05 20:37:11 Scanning 21:1/101
    Nov 05 20:37:11 Queued 31 files (157327 bytes) to 21:1/101
    Nov 05 20:37:11 Polling BINKP node 21:1/101
    Nov 05 20:37:11 Connecting to XXX.XXX.XXX.XXX:24555
    Nov 05 20:37:11 Connected
    Nov 05 20:37:11 System Agency BBS
    Nov 05 20:37:11 SysOp Avon
    Nov 05 20:37:11 Mailer Mystic/1.12A36 binkp/1.0
    Nov 05 20:37:11 Sending: 032c6fb3.pkt (40,110 bytes)
    Nov 05 20:37:11 Receiving: 00000001.su0 (3,949 bytes)
    Nov 05 20:37:41 Socket read error 10054
    Nov 05 20:37:41 Socket read error 10054
    Nov 05 20:37:41 Socket read error 10054
    Nov 05 20:37:41 Error receiving data (Socket read buffer error 10054 size=0/2256
    Nov 05 20:37:41 Remote disconnect
    Nov 05 20:37:41 Session complete (0 sent, 1 rcvd, 0 skip)

    [snip]

    And at Agency MIS2 BinkP logging shows


    [snip]


    ---------- Mystic v1.12 A36 Sun, Nov 05 2017 (loglevel 3)
    + 20:36:37 MANAGER Starting event system
    + 20:36:37 MANAGER Starting 1 server(s)
    + 20:36:37 BINKP Listening on IPV4 port 24555 using interface "0.0.0.0"
    + 20:36:37 EVENT Starting 11 event(s)
    + 20:36:38 EVENT Detected semaphore: \\TOTAL-FM-STUDIO\mx-impt\newtrk.txt
    + 20:36:38 EVENT Event begin: Build Hourly Song Data
    + 20:36:38 EVENT Command line: c:\bbs\mystic\add-song.bat
    + 20:36:38 EVENT Command result: 0
    + 20:36:38 EVENT Event complete: Build Hourly Song Data
    + 20:37:11 BINKP > Connect on slot 1/5
    + 20:37:11 BINKP 1-Address XXX.XXX.XXX.XXX
    + 20:37:11 BINKP 1-HostName AGENCY
    + 20:37:11 BINKP 1-System fsxHUB [fsxNet WHQ]
    + 20:37:11 BINKP 1-SysOp Paul Hayton
    + 20:37:11 BINKP 1-Mailer Mystic/1.12A36 binkp/1.0
    + 20:37:11 BINKP 1-Queued 1 files for 21:1/100@fsxnet
    + 20:37:11 BINKP 1-Sending: 00000001.su0 (3,949 bytes)
    + 20:37:11 BINKP 1-Receiving: 032c6fb3.pkt (40,110 bytes)
    + 20:37:41 BINKP 1-Session timeout
    + 20:37:41 BINKP 1-Session complete (0 sent, 0 rcvd, 0 skip)

    [snip]

    So there are still issues when trying to poll between copies of the same version of Mystic running on the same BOX - a Win7 32 bit box.

    Some thoughts

    - MIS2 logging needs to clearly show dates as well as times against each
    logged action like MIS logging does/did - without this is becomes a mess a times to look back though backed up logging and try to figure out when things happened when debugging. :)

    - MIS2 logging needs to be realtime to HDD like MIS was. MIS2 logs do not record much at all until you close MIS2 down. I may be wrong but something feels off.

    My reported issue could be related to the fact that polling is happening
    within the same BOX Fidopoll <> BinkP server using a 192.168.xxx.xxx:24555 address ... it's the only thing I can think that may be remotely unique to my issue..

    [time passes]

    When I checked the MIS2 BinkP logs for the HUB I also see other systems
    having issues polling MIS2 at 1/100 and getting remote disconnects (I'm not
    the only one - phew) I will send you the MIS2 log and rename it MIS2-NET1HUB-A36-2017-11-04.TXT

    At this stage I am scratching my head how to get reliable echomail/netmail
    etc. in/out of Agency 1/101 as the only way seems to be reverting to a
    Fidopoll from A35 .. I also suspect based on the logging is see at 1/100 MIS2 that other nodes are having issues collecting their traffic.

    Best, Paul

    --- Mystic BBS v1.12 A36 2017/11/04 (Windows/32)
    * Origin: Agency BBS | telnet://agency.bbs.geek.nz (21:1/101)
  • From Avon@21:1/101 to g00r00 on Sunday, November 05, 2017 21:24:27
    On 11/05/17, Avon pondered and said...

    At this stage I am scratching my head how to get reliable
    echomail/netmail etc. in/out of Agency 1/101 as the only way seems to be reverting to a Fidopoll from A35 .. I also suspect based on the logging
    is see at 1/100 MIS2 that other nodes are having issues collecting their traffic.

    For now 1/100 HUB is back on 1.12 A35 to ensure all nodes get their echomail etc.. and Agency is rolled back a few iterations of A36 ... but I needed to
    do this to get my messages in/out :)

    --- Mystic BBS v1.12 A36 (Windows/32)
    * Origin: Agency BBS | telnet://agency.bbs.geek.nz (21:1/101)