TZUTC: -0300
MSGID: 4.fidonethotdoged@4:902/26 22f3cd7b
PID: Synchronet 3.17c-Linux Apr 8 2020 GCC 6.3.0
TID: SBBSecho 3.10-Linux r3.159 Apr 8 2020 GCC 6.3.0
CHRS: UTF-8 4
(sorry the long message and my poor english)
Hi all i write this message to Synchornet support area and now here too.
I try to detect an error that hotdoged won't receive netmail in some case.
I wish if hotdoged author can add debug setting to log file for
importing mesage stage, to help me to find the issue
Thanks!
-------------------------
My settings:
I have 2 setup points at my sbbsecho.ini (same settings for each point,
obviously changed the name/password/comment)
4:902/26.3 and 4:902/26.10
Ex:
[node:4:902/26.3@fidonet]
Name = Fernando Toledo
Comment = movil
Archive = ZIP
PacketType = 2+
PacketPwd = **
AreaFix = true
AreaFixPwd = **
SessionPwd = **
TicFilePwd = **
Inbox =
Outbox =
Passive = false
Direct = false
Notify = false
Keys =
Status = Hold
LocalAddress = 4:902/26
GroupHub =
BinkpHost =
BinkpPort = 24554
BinkpPoll = false
BinkpPlainAuthOnly = false
BinkpAllowPlainAuth = true
BinkpAllowPlainText = true
BinkpTLS = false
BinkpSourceAddress =
I have openxp5 as client for 4:902/26.3 and HotDogEd for 4:902/26.10
My bbs node is 4:902/26 and both client connect via binkIT to it
cases:
1) send/receive netmail between points (from .3 to .10 or vice versa) =
working
2) send netmails from points to sbbs node = working
3) send from 4:902/26 to point 4:902/26.3 = working
4) echomails to both points = working
5) send netmail from 4:902/26 to point 4:902/26.10 = FAIL
HotdogtEd do not show the netmail.
Logs:
creating netmail to .10 from the bbs node (4:902/26)
Apr 8 23:27:54 cpe-001e8ccf4132 synchronet: term Node 1
'?slyedit /sbbs/node1/MSGTMP DCT' returned 0
Apr 8 23:27:54 cpe-001e8ccf4132 synchronet: term Node 1
NetMail subject: prueba 1
Apr 8 23:27:54 cpe-001e8ccf4132 synchronet: term Node 1 sent
NetMail to FERNANDO TOLEDO# (4:902/26.10)
sbbecho sems to make the .10 package
2020-04-08 23:28:50 Configured: 1 archivers, 14 linked-nodes, 3 echolists
2020-04-08 23:28:50 NetMail directory: /sbbs/fido/netmail/
2020-04-08 23:28:50 Secure Inbound directory: /sbbs/fido/inbound/
2020-04-08 23:28:50 Non-secure Inbound directory:
/sbbs/fido/inbound.nosecure/
2020-04-08 23:28:50 Outbound (BSO root) directory: /sbbs/fido/outbound/
2020-04-08 23:28:50 Read 213 areas from ../data/areas.bbs
2020-04-08 23:28:50 Read 0 areas from ../data/badareas.lst
2020-04-08 23:28:50 Read 292 echo statistics from ../data/echostats.ini
2020-04-08 23:28:50 Created NetMail (1.msg) from Fernando Toledo
(4:902/26) to FERNANDO TOLEDO# (4:902/26.10), attr: 0381, subject: prueba 1
2020-04-08 23:28:50 Packing NetMail (1.msg) from Fernando Toledo
(4:902/26) to FERNANDO TOLEDO# (4:902/26.10), attr: 0381, subject: prueba 1
2020-04-08 23:28:50 Node (4:902/26.10) successfully locked via:
/sbbs/fido/outbound/0386001a.pnt/0000000a.bsy
2020-04-08 23:28:50 Adding NetMail (1.msg) to new packet for
4:902/26.10: /sbbs/fido/outbound/0386001a.pnt/0000000a.hut
2020-04-08 23:28:50 Deleting /sbbs/fido/netmail/1.msg (from line 5327)
2020-04-08 23:28:50 Touching outgoing semfile: ../data/binkout.now
2020-04-08 23:28:50 Writing 0 areas to ../data/badareas.lst
2020-04-08 23:28:50 Deleting
/sbbs/fido/outbound/0386001a.pnt/0000000a.bsy (from line 3032)
2020-04-08 23:28:50 Deleting /sbbs/ctrl/sbbsecho.bsy (from line 3038)
2020-04-08 23:28:50 SBBSecho (PID 14027) exiting with error level 0,
NetMail(0 imported, 1 exported, 1 packed)
i use python-ftn tool to see packet detail, sems fine
root@cpe-001e8ccf4132:/tmp# ftn-scanpkt --debug 0000000a.hut
2020-04-08 23:31:18 app:DEBUG [14779] set umask to 0022.
2020-04-08 23:31:18 app:DEBUG [14779] reading config from /etc/ftn/ftn.cfg
2020-04-08 23:31:18 app:DEBUG [14779] finished generic setup
2020-04-08 23:31:18 message:DEBUG [14779] parsing a message
2020-04-08 23:31:18 message:DEBUG [14779] looking for FMPT
2020-04-08 23:31:18 message:DEBUG [14779] looking for TOPT
2020-04-08 23:31:18 message:DEBUG [14779] set destPoint = 10
======================================================================
0000000a.hut: 4:902/26 -> 4:902/26.10 @ 2020-04-08 23:28:50
======================================================================
hotdoged call to the node and get the packet:
Apr 8 23:38:32 cpe-001e8ccf4132 synchronet: term Node 2 terminal type:
80x24 DUMB
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP connection
accepted from: 192.168.10.30 port 50744
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP JavaScript
service thread started
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP BinkIT/2.37
invoked with options:
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP
JSBinkP/1.122 inbound connection from 192.168.10.30:50744
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_NUL command args: OPT CRAM-MD5-0df9046bab0fd111b81c86b82dadc18c CRYPT
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_NUL
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_NUL
command args: SYS Point 10
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_NUL command args: SYS Dock Sud BBS
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_NUL
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_NUL command args: ZYZ Ragnarok
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_NUL
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_NUL command args: LOC Dock Sud, Bs As, Argentina
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_NUL
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_NUL command args: NDL 115200,TCP,BINKP
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_NUL
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_NUL command args: TIME Wed Apr 08 2020 23:38:36 GMT-0300
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_NUL
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_NUL command args: VER BinkIT/2.37,JSBinkP/1.122,sbbs3.17c/Linux binkp/1.1
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_NUL
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_ADR command args: 4:902/26@fidonet 666:1/1@latinet 21:2/151@fsxnet
618:500/45@micronet
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_ADR
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_NUL
command args: ZYZ Fernando Toledo
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_NUL
command args: LOC Android device
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_NUL
command args: NDL 115200,TCP,BINKP
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_NUL
command args: VER jNode/Android binkp/1.1
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Peer
version: jNode/Android binkp/1.1
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_NUL
command args: TIME Wed, 08 Apr 2020 23:38:35 -0300
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_ADR
command args: 4:902/26.10@fidonet
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_PWD
command args: CRAM-MD5-XXXXXXXXXXXX
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Remote
addresses: 4:902/26.10@fidonet
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Inbound
session for: 4:902/26.10@fidonet
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP CRAM-MD5
password match for 4:902/26.10@fidonet
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Adding
outbound files for 4:902/26.10@fidonet
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Locking
/sbbs/fido/outbound/0386001a.pnt/0000000a.bsy
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Lock
successful.
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Adding
'/sbbs/fido/outbound/0386001a.pnt/0000000a.hut' as 'ef93z3i1.pkt'
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_OK command args: secure
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_OK
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
file: /sbbs/fido/outbound/0386001a.pnt/0000000a.hut (0.5KB)
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_FILE command args: ef93z3i1.pkt 532 1586399330 0
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_FILE
command
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending 532
bytes of data
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent file:
/sbbs/fido/outbound/0386001a.pnt/0000000a.hut (0.5KB)
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_EOB command args:
Apr 8 23:38:36 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_EOB
command
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_EOB
command args:
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP We got an
M_EOB, but there are still 1 files pending M_GOT
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_EOB command args:
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_EOB
command
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_GOT
command args: ef93z3i1.pkt 532 1586399330
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Got M_EOB
command args:
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sending
M_EOB command args:
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Sent M_EOB
command
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Remote host
closed socket
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Deleted
file: /sbbs/fido/outbound/0386001a.pnt/0000000a.hut
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP Unlocking
/sbbs/fido/outbound/0386001a.pnt/0000000a.bsy.
Apr 8 23:38:37 cpe-001e8ccf4132 synchronet: srvc 0306 BINKP service
thread terminated (0 clients remain, 6 total, 21 served)
the netmail do not show at hotdoged
if i write netmail from the .3 point to .10.. is receive perfect.
global sbbsecho setting:
TempDirectory = ../temp/sbbsecho
ZoneBlindThreshold = 65535
StrictPacketPasswords = true
EchomailNotify = true
AutoAddSubs = true
BsyTimeout = 12H
BsoLockDelay = 10S
BsoLockAttempts = 60
MaxEchomailAge = 60D
MaxNetmailAge = 0S
RelayFilteredMsgs = false
DeleteNetmail = true
DeletePackets = true
IgnoreNetmailDestAddr = false
IgnoreNetmailSentAttr = false
IgnoreNetmailRecvAttr = false
IgnoreNetmailLocalAttr = false
DefaultRecipient = SYSOP
UseFTNDomains = false
OutgoingSemaphore=../data/binkout.now
IgnoreNetmailKillAttr = false
MinFreeDiskSpace = 10M
StripSoftCRs = false
UseOutboxes = true
AutoAddToAreaFile = true
AutoUTF8 = true
I'm test with several configs and i can not detect the failure
Why the netmail is received from point .3 and not from the bbs node?
i'm run out of ideas
=|
ps: i will write to hotdoged author too. i hope that can add some debug
log to helpme to find the issue.
--- SBBSecho 3.10-Linux
* Origin: Dock Sud BBS - http://bbs.docksud.com.ar (4:902/26)
SEEN-BY: 1/123 4/0 88/0 90/0 1 135/367 226/30 227/114 229/426 452
SEEN-BY: 229/1014 240/5832 249/206 317 400 317/3 322/757 342/200 633/280
SEEN-BY: 900/0 100 102 108 902/0 6 10 19 26 27 100
PATH: 902/26 27 90/1 229/426
|
