Re: Question about bin kit
By: echicken to Al on Fri Dec 14 2018 06:15 pm
For some reason mail to points is not sent on a BINKOUT event. I'm
not sure why that is.
Mildly curious about this. When you have outbound mail waiting to be sent to a point, does "Unhandled/Unexpected point path" show up in your log during BINKOUT, or any other errors?
I wrote a netmail to myself just for a test. Sbbsecho packed the netmail into /sbbs/fido/outbound/009902f5.pnt/00000001.dut and touched data/binkout.now to trigger the BINKOUT event.. this is the log, no errors that I can see..
---- begin snip ----
Dec 15 04:00:22 trmb synchronet: evnt Semaphore signaled for Timed Event: BINKO UT
Dec 15 04:00:22 trmb synchronet: evnt Running timed event: BINKOUT
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Executing external: ?binkit
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT BinkIT/2.12 invoked with options:
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Outbound roots: ["/sbbs/fido/outb ound","/sbbs/fido/outbound","/sbbs/fido/outbound","/sbbs/fido/outbound","/sbbs/ fido/outbound","/sbbs/fido/outbound"]
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Outbound dirs: ["/sbbs/fido/outbo und/","/sbbs/fido/outbound.002/","/sbbs/fido/outbound.003/","/sbbs/fido/outboun d.004/","/sbbs/fido/outbound.00b/","/sbbs/fido/outbound.015/","/sbbs/fido/outbo und.018/","/sbbs/fido/outbound.020/","/sbbs/fido/outbound.02c/","/sbbs/fido/out bound.13c/","/sbbs/fido/outbound.539/"]
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.002/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.002/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.003/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.003/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.004/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.004/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.00b/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.00b/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.015/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.015/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.018/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.018/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.020/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.020/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.02c/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.02c/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.13c/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.13c/.
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Running outbound dir /sbbs/fido/o utbound.539/
Dec 15 04:00:22 trmb synchronet: evnt BINKOUT Done checking in /sbbs/fido/outbo und.539/.
Dec 15 04:00:22 trmb synchronet: evnt Timed event: BINKOUT returned 0
---- end snip ----
After that I touched data/binkpoll.now and the BINKPOLL event ran and did send that netmail, here's that log..
---- begin snip ----
Dec 15 04:04:42 trmb synchronet: evnt Semaphore signaled for Timed Event: BINKP OLL
Dec 15 04:04:42 trmb synchronet: evnt Running timed event: BINKPOLL
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Executing external: ?binkit -p Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL BinkIT/2.12 invoked with options : -p
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Outbound roots: ["/sbbs/fido/out bound","/sbbs/fido/outbound","/sbbs/fido/outbound","/sbbs/fido/outbound","/sbbs /fido/outbound","/sbbs/fido/outbound"]
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Outbound dirs: ["/sbbs/fido/outb ound/","/sbbs/fido/outbound.002/","/sbbs/fido/outbound.003/","/sbbs/fido/outbou nd.004/","/sbbs/fido/outbound.00b/","/sbbs/fido/outbound.015/","/sbbs/fido/outb ound.018/","/sbbs/fido/outbound.020/","/sbbs/fido/outbound.02c/","/sbbs/fido/ou tbound.13c/","/sbbs/fido/outbound.539/"]
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.002/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.002/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.003/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.003/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.004/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.004/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.00b/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.00b/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.015/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.015/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.018/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.018/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.020/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.020/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.02c/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.02c/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.13c/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.13c/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running outbound dir /sbbs/fido/ outbound.539/
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Done checking in /sbbs/fido/outb ound.539/.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Running polls
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL poll_node 1:153/757.1@fidonet, o utbound_dir: /sbbs/fido/outbound
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Locking /sbbs/fido/outbound/0099 02f5.pnt/00000001.bsy
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Lock successful.
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Attempting poll for node 1:153/7 57.1@fidonet
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL JSBinkP/1.112 callout to 1:153/7 57.1@fidonet started
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL connecting to 1:153/757.1@fidone t at trmb.ca
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Connecting to trmb.ca:24555
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Connection to trmb.ca:24555 succ essful
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_NUL command args: OPT CRYPT
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_NUL command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_NUL command args: SYS The Rusty MailBox
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_NUL command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_NUL command args: ZYZ Alan Ianson
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_NUL command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_NUL command args: LOC Penticton, BC Canada
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_NUL command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_NUL command args: NDL 115200,TCP,BINKP
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_NUL command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_NUL command args: TIME
Sat Dec 15 2018 04:04:42 GMT-0800 (PST)
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_NUL command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_NUL command args: VER BinkIT/2.12,JSBinkP/1.112,sbbs3.17a/Linux binkp/1.1
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_NUL command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_ADR command args: 1:15 3/757@fidonet 1:153/0@fidonet 44:250/0@dorenet 21:4/106@fsxnet 32:1/5@gamenet 1 337:3/101@tqwnet 11:1/201@wwivftn
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_ADR command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_NUL command args: SYS The Rusty MailBox
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_NUL command args: ZYZ Alan
Ianson
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_NUL command args: LOC Pent icton, BC
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_NUL command args: VER BBBS /Li6 v4.10 Toy-3 binkp/1.0
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Peer version: BBBS/Li6 v4.10 Toy -3 binkp/1.0
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_NUL command args: NDL XX,C M,IBN
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_ADR command args: 1:153/75 7.1@fidonet 21:4/106.2@fsxnet 32:1/5.0@gamenet 44:250/0.0@dorenet 1337:3/100.1@ tqwnet
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_PWD command args: BLIN KING
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_PWD command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_OK command args:
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Authentication successful:
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Unconfigured address 32:1/5@game net
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Unconfigured address 44:250/0@do renet
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Unconfigured address 1337:3/100. 1@tqwnet
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Adding outbound files for 1:153/ 757.1@fidonet
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Adding '/sbbs/fido/outbound/0099 02f5.pnt/00000001.dut' as '786wo2n2.pkt'
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Adding outbound files for 21:4/1 06.2@fsxnet
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_EOB command args:
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending file: /sbbs/fido/outboun d/009902f5.pnt/00000001.dut (0.4KB)
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_FILE command args: 786 wo2n2.pkt 450 1544875218 0
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_FILE command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending 450 bytes of data
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent file: /sbbs/fido/outbound/0 09902f5.pnt/00000001.dut (0.4KB)
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sending M_EOB command args:
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Sent M_EOB command
Dec 15 04:04:42 trmb synchronet: evnt BINKPOLL Got M_GOT command args: 786wo2n2 .pkt 450 1544875218
Dec 15 04:04:47 trmb synchronet: evnt BINKPOLL Remote host closed socket
Dec 15 04:04:47 trmb synchronet: evnt BINKPOLL Removed '/sbbs/fido/outbound/009 902f5.pnt/00000001.dut'.
Dec 15 04:04:47 trmb synchronet: evnt BINKPOLL Unlocking /sbbs/fido/outbound/00 9902f5.pnt/00000001.bsy.
---- end snip ----
A fair bit of logs there but I'm not sure what you need to see.. :)
I wonder if the BINKOUT event is not looking in the outbound/*.pnt directories to see if there is mail/files to send?
Ttyl :-),
Al
... Aw Mom, You act like I'm not even wearing a bungee cord!
---
þ Synchronet þ The Rusty MailBox - Penticton, BC Canada
* Origin: Vertrauen - [vert/cvs/bbs].synchro.net (1:103/705)