Subj : error to get netmail (para carlos) To : Fidonet.HOTDOGED From : Fernando Toledo Date : Wed Nov 10 2021 12:38:39 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) .