TZUTC: -0300
MSGID: 85.fidonethotdoged@4:902/26 25f11dd4
REPLY: 4.fidonethotdoged@4:902/26 22f3cd7b
PID: Synchronet 3.19a-Linux master/ccc0e4019 Oct 7 2021 GCC 6.3.0
TID: SBBSecho 3.14-Linux master/ccc0e4019 Oct 7 2021 GCC 6.3.0
BBSID: DOCKSUD
CHRS: ASCII 1
NOTE: FSEditor.js v1.104
Re: error to get netmail
By: Fernando Toledo to Fidonet.HOTDOGED on Thu Apr 09 2020 00:33:11
Mira Carlos, Este era el reporte que envie hace un tiempo:
> (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.
--
Ragnarok
Dock Sud BBS
https://bbs.docksud.com.ar
tw: @docksud
fb: DockSudBBS
--- SBBSecho 3.14-Linux
* Origin: Dock Sud BBS - http://bbs.docksud.com.ar (4:902/26)
SEEN-BY: 1/123 4/0 14/0 80/1 88/0 90/0 1 105/81 120/340 123/131 226/30
SEEN-BY: 227/114 702 229/424 426 428 452 664 700 240/5832 249/206
SEEN-BY: 249/317 400 282/1038 301/1 317/3 322/757 342/200 633/280
SEEN-BY: 900/0 100 102 106 108 902/0 6 7 10 19 25 26 27 100
PATH: 902/26 27 90/1 229/426
|