Subj : session timeouts
To : Edmund Wong
From : Al
Date : Tue Nov 30 2021 05:09 am
Hello Edmund,
EW> I think I'm having some issues with my binkp connection wrt TICs.
EW> Here's a sample of the log:
EW> 2021.11.28 03:08:58 BINKP 1-Receiving: DB4G.ZIP (2,531,781 bytes)
EW> 2021.11.28 03:09:29 BINKP 1-Session timeout
EW> 2021.11.28 03:09:29 BINKP 1-Session ended (0 sent, 0 rcvd, 0 skip)
EW> ...
Here is my log from a failed session when sending these files.
==== Begin: "log.txt" ====
27-Nov-2021 11:18:40 mbcico[29940] MBCICO v1.0.7.22
27-Nov-2021 11:18:40 mbcico[29940] Cmd: mbcico f7083.n153.z1.fidonet
+ 27-Nov-2021 11:18:40 mbcico[29940] Options: Call WaZOO EMSI Freqs Zmodem
ZedZap Hydra PLZ GZ/BZ2 NoNR CRC
+ 27-Nov-2021 11:18:40 mbcico[29940] Calling 1:153/7083@fidonet (Eagles's BBS,
phone (null))
+ 27-Nov-2021 11:18:40 mbcico[29940] Open TCP connection to
"bbs.seabot.space:24554"
+ 27-Nov-2021 11:18:40 mbcico[29940] Trying IPv4 223.255.146.70 port 24554
+ 27-Nov-2021 11:18:40 mbcico[29940] Established IBN/TCP IPv4 connection with
223.255.146.70, port 24554
+ 27-Nov-2021 11:18:40 mbcico[29940] GeoIP location: Hong Kong, HK AS
+ 27-Nov-2021 11:18:40 mbcico[29940] Start outbound Binkp session with
1:153/7083@fidonet
+ 27-Nov-2021 11:18:40 mbcico[29940] Binkp: start session
+ 27-Nov-2021 11:18:40 mbcico[29940] Binkp: node 1:153/7083@fidonet
+ 27-Nov-2021 11:18:41 mbcico[29940] Options :
CRAM-MD5-dbf32f237a350dbca448394d400cf448
+ 27-Nov-2021 11:18:41 mbcico[29940] System : Eagle's BBS
+ 27-Nov-2021 11:18:41 mbcico[29940] Sysop : Edmund Wong
+ 27-Nov-2021 11:18:41 mbcico[29940] Time : Sun, 28 Nov 2021 03:18:57 +0800
+ 27-Nov-2021 11:18:41 mbcico[29940] Uses : Mystic/1.12A47 binkp/1.0
+ 27-Nov-2021 11:18:41 mbcico[29940] Binkp: M_NUL "BUILD 2021/11/22 11:43:05
Linux/32"
+ 27-Nov-2021 11:18:41 mbcico[29940] address : 1:153/7083@FidoNet
+ 27-Nov-2021 11:18:41 mbcico[29940] address : 27:1/0@pwnet
+ 27-Nov-2021 11:18:41 mbcico[29940] address : 1:153/757.23@FidoNet
+ 27-Nov-2021 11:18:41 mbcico[29940] Binkp: MD5 protected session
+ 27-Nov-2021 11:18:41 mbcico[29940] Binkp: mail 0, files 5065412 bytes
+ 27-Nov-2021 11:18:41 mbcico[29940] Binkp: send
"/opt/mbse/ftp/pub/bbs/dbridge/DB4G.ZIP" as "DB4G.ZIP"
+ 27-Nov-2021 11:18:41 mbcico[29940] Binkp: size 2531781 bytes, dated Nov 27
11:05:08, comp No
+ 27-Nov-2021 11:18:41 mbcico[29940] Binkp: M_NUL "QSIZE 0 files 0 bytes"
! 27-Nov-2021 11:19:12 mbcico[29940] tty_read: error flag
? 27-Nov-2021 11:19:12 mbcico[29940] Binkp: receiver status Error
+ 27-Nov-2021 11:19:12 mbcico[29940] Binkp: session finished, rc=108
+ 27-Nov-2021 11:19:14 mbcico[29940] Closing TCP connection, connected 34.00s
+ 27-Nov-2021 11:19:14 mbcico[29940] Call to 1:153/7083@fidonet failed
(rc=108)
+ 27-Nov-2021 11:19:14 mbcico[29940] Terminated with error 108
+ 27-Nov-2021 11:19:14 mbcico[29940] Sent 614400 bytes, received 0 bytes, avg
19200 cps
+ 27-Nov-2021 11:19:14 mbcico[29940] Connected 34.00s
27-Nov-2021 11:19:14 mbcico[29940] MBCICO finished in 34.00s
==== End: "log.txt" ====
If you look 9 lines up there is an tty_read error. Looking up error 108 in the
MBSE documentation that is listed as a file transfer error.
I also send these files to my own Mystic BBS and I have never had this kind of
error when transferring files.
I am also linked to three Mystic BBSs and these errors never happen when
transferring mail/files. At least I haven't seen it and it hasn't been
reported to me.
And here is the following session that looks successful.
==== Begin: "log.txt" ====
27-Nov-2021 11:21:01 mbcico[29941] MBCICO v1.0.7.22
27-Nov-2021 11:21:01 mbcico[29941] Cmd: mbcico f7083.n153.z1.fidonet
+ 27-Nov-2021 11:21:01 mbcico[29941] Options: Call WaZOO EMSI Freqs Zmodem
ZedZap Hydra PLZ GZ/BZ2 NoNR CRC
+ 27-Nov-2021 11:21:01 mbcico[29941] Calling 1:153/7083@fidonet (Eagles's BBS,
phone (null))
+ 27-Nov-2021 11:21:01 mbcico[29941] Open TCP connection to
"bbs.seabot.space:24554"
+ 27-Nov-2021 11:21:01 mbcico[29941] Trying IPv4 223.255.146.70 port 24554
+ 27-Nov-2021 11:21:01 mbcico[29941] Established IBN/TCP IPv4 connection with
223.255.146.70, port 24554
+ 27-Nov-2021 11:21:01 mbcico[29941] GeoIP location: Hong Kong, HK AS
+ 27-Nov-2021 11:21:01 mbcico[29941] Start outbound Binkp session with
1:153/7083@fidonet
+ 27-Nov-2021 11:21:01 mbcico[29941] Binkp: start session
+ 27-Nov-2021 11:21:01 mbcico[29941] Binkp: node 1:153/7083@fidonet
+ 27-Nov-2021 11:21:01 mbcico[29941] Options :
CRAM-MD5-7ed3cdb5b4ac4e35b34b6f23936d19bb
+ 27-Nov-2021 11:21:01 mbcico[29941] System : Eagle's BBS
+ 27-Nov-2021 11:21:01 mbcico[29941] Sysop : Edmund Wong
+ 27-Nov-2021 11:21:01 mbcico[29941] Time : Sun, 28 Nov 2021 03:21:17 +0800
+ 27-Nov-2021 11:21:01 mbcico[29941] Uses : Mystic/1.12A47 binkp/1.0
+ 27-Nov-2021 11:21:01 mbcico[29941] Binkp: M_NUL "BUILD 2021/11/22 11:43:05
Linux/32"
+ 27-Nov-2021 11:21:01 mbcico[29941] address : 1:153/7083@FidoNet
+ 27-Nov-2021 11:21:01 mbcico[29941] address : 27:1/0@pwnet
+ 27-Nov-2021 11:21:01 mbcico[29941] address : 1:153/757.23@FidoNet
+ 27-Nov-2021 11:21:02 mbcico[29941] Binkp: MD5 protected session
+ 27-Nov-2021 11:21:02 mbcico[29941] Binkp: mail 0, files 5065412 bytes
+ 27-Nov-2021 11:21:02 mbcico[29941] Binkp: send
"/opt/mbse/ftp/pub/bbs/dbridge/DB4G.ZIP" as "DB4G.ZIP"
+ 27-Nov-2021 11:21:02 mbcico[29941] Binkp: size 2531781 bytes, dated Nov 27
11:05:08, comp No
+ 27-Nov-2021 11:21:02 mbcico[29941] Binkp: M_NUL "QSIZE 0 files 0 bytes"
+ 27-Nov-2021 11:21:05 mbcico[29941] Binkp: OK 2531781 bytes sent in 2.740
seconds (902.351 Kb/s)
+ 27-Nov-2021 11:21:05 mbcico[29941] Binkp: send
"/opt/mbse/var/ticqueue/61472b96.tic" as "61472b96.tic"
+ 27-Nov-2021 11:21:05 mbcico[29941] Binkp: size 699 bytes, dated Nov 27
11:07:56, comp No
+ 27-Nov-2021 11:21:05 mbcico[29941] Binkp: OK 699 bytes sent in 0.001 seconds
(682.617 Kb/s)
+ 27-Nov-2021 11:21:05 mbcico[29941] Binkp: send
"/opt/mbse/ftp/pub/bbs/dbridge/DB4S.ZIP" as "DB4S.ZIP"
+ 27-Nov-2021 11:21:05 mbcico[29941] Binkp: size 2531421 bytes, dated Nov 27
11:05:09, comp No
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: OK 2531421 bytes sent in 5.995
seconds (412.359 Kb/s)
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: send
"/opt/mbse/var/ticqueue/61472b98.tic" as "61472b98.tic"
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: size 699 bytes, dated Nov 27
11:07:57, comp No
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: OK 699 bytes sent in 0.001 seconds
(682.617 Kb/s)
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: send
"/opt/mbse/var/bso/outbound/0000e74a.saa" as "0000e74a.saa"
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: size 812 bytes, dated Nov 27
11:10:17, comp No
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: OK 812 bytes sent in 0.001 seconds
(792.969 Kb/s)
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: M_GOT "DB4G.ZIP 2531781
1638039908"
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: remote GOT "DB4G.ZIP"
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: M_GOT "61472b96.tic 699
1638040076"
+ 27-Nov-2021 11:21:11 mbcico[29941] Binkp: remote GOT "61472b96.tic"
+ 27-Nov-2021 11:21:15 mbcico[29941] Binkp: M_GOT "DB4S.ZIP 2531421
1638039909"
+ 27-Nov-2021 11:21:15 mbcico[29941] Binkp: remote GOT "DB4S.ZIP"
+ 27-Nov-2021 11:21:15 mbcico[29941] Binkp: M_GOT "61472b98.tic 699
1638040077"
+ 27-Nov-2021 11:21:15 mbcico[29941] Binkp: remote GOT "61472b98.tic"
+ 27-Nov-2021 11:21:15 mbcico[29941] Binkp: M_GOT "0000e74a.saa 812
1638040217"
+ 27-Nov-2021 11:21:15 mbcico[29941] Binkp: remote GOT "0000e74a.saa"
+ 27-Nov-2021 11:21:15 mbcico[29941] Binkp: session finished, rc=0
+ 27-Nov-2021 11:21:17 mbcico[29941] Closing TCP connection, connected 16.00s
+ 27-Nov-2021 11:21:17 mbcico[29941] Call to 1:153/7083@fidonet successful
(rc=0)
+ 27-Nov-2021 11:21:17 mbcico[29941] Sent 5065412 bytes, received 0 bytes, avg
361815 cps
+ 27-Nov-2021 11:21:17 mbcico[29941] Connected 16.00s
27-Nov-2021 11:21:17 mbcico[29941] MBCICO finished in 16.00s
==== End: "log.txt" ====
EW> So right now, I have a bunch of files in my echomail/in that
EW> I'll sort out; but I'd like to ask what might be going on
EW> with my system?
EW> Any help appreciated
Anyone know why this would happen?
I am at a loss as to where to look next or what the issue might be.
Ttyl :-),
Al
... If you don't think women are explosive, drop one!
--- GoldED+/LNX 1.1.5-b20180707
* Origin: The Rusty MailBox - Penticton, BC Canada (1:153/757)