Package: binkd Version: 1.0.4-1.1~perl Severity: normal I recompile binkd with perl support and have error on receive file ? 23 Mar 16:39:52 [9133] Perl error: Modification of a read-only value attempted.
in result file not received /var/log/binkd/binkd 23 Mar 16:39:20 [9126] BEGIN, binkd/1.0.4/Linux /etc/binkd/binkd.cfg -q -C 23 Mar 16:39:20 [9126] perl_init(): /etc/binkd/test.pl 23 Mar 16:39:20 [9126] perl_init(): parse rc=0 23 Mar 16:39:20 [9126] perl_setup(): perl context 0xb86f0b38 23 Mar 16:39:20 [9126] perl_setup(): %config done 23 Mar 16:39:20 [9126] perl_setup(): %domain done 23 Mar 16:39:20 [9126] perl_setup(): @addr done 23 Mar 16:39:20 [9126] perl_setup(): @ftrans done 23 Mar 16:39:20 [9126] perl_setup(): @overwrite done 23 Mar 16:39:20 [9126] perl_setup(): @skip done 23 Mar 16:39:20 [9126] perl_setup(): %share done 23 Mar 16:39:20 [9126] perl_setup(): %node done 23 Mar 16:39:20 [9126] perl_init(): running body 23 Mar 16:39:20 [9126] perl_init(): end 23 Mar 16:39:20 [9126] perl_on_start() - 23 Mar 16:39:20 [9126] binkd started 23 Mar 16:39:20 [9126] perl_on_start() end 23 Mar 16:39:20 [9126] unlink_pid_file: /run/ftn/binkd.pid: Нет такого файла или каталога 23 Mar 16:39:20 [9126] created /run/ftn/binkd.pid 23 Mar 16:39:20 [9126] servmgr started 23 Mar 16:39:20 [9127] clientmgr started - 23 Mar 16:39:52 [9126] incoming from 192.168.88.5 (58948) 23 Mar 16:39:52 [9126] started server #1, id=9133 23 Mar 16:39:52 [9133] binkp init done, socket # is 5 + 23 Mar 16:39:52 [9133] incoming session with 192.168.88.5 (58948) 23 Mar 16:39:52 [9133] send message NUL OPT CRAM-MD5-13e74f13e5895816d8b24af9d0f161ee 23 Mar 16:39:52 [9133] send message NUL SYS Ivan's BBS 23 Mar 16:39:52 [9133] send message NUL ZYZ Ivan Ivanov 23 Mar 16:39:52 [9133] send message NUL LOC SPB, Russia 23 Mar 16:39:52 [9133] send message NUL NDL 115200,TCP,BINKP 23 Mar 16:39:52 [9133] send message NUL TIME Wed, 23 Mar 2016 16:39:52 +0300 23 Mar 16:39:52 [9133] send message NUL VER binkd/1.0.4/Linux binkp/1.1 23 Mar 16:39:52 [9133] send_ADR(): got 0 remote addresses 23 Mar 16:39:52 [9133] send message ADR 100:0/200@metiznet 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 2 (r=1, w=1) 23 Mar 16:39:52 [9133] recvd hdr: 11 (msg) 23 Mar 16:39:52 [9133] put next msg to obuf, 48 23 Mar 16:39:52 [9133] put next msg to obuf, 17 23 Mar 16:39:52 [9133] put next msg to obuf, 18 23 Mar 16:39:52 [9133] put next msg to obuf, 18 23 Mar 16:39:52 [9133] put next msg to obuf, 23 23 Mar 16:39:52 [9133] put next msg to obuf, 39 23 Mar 16:39:52 [9133] put next msg to obuf, 34 23 Mar 16:39:52 [9133] put next msg to obuf, 22 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 2 (r=1, w=1) 23 Mar 16:39:52 [9133] got block: 11 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL SYS 00sudt - 23 Mar 16:39:52 [9133] SYS 00sudt 23 Mar 16:39:52 [9133] sending 219 byte(s) 23 Mar 16:39:52 [9133] send() done, rc=219 23 Mar 16:39:52 [9133] data sent 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 10 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 10 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL ZYZ Denis - 23 Mar 16:39:52 [9133] ZYZ Denis 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 15 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 15 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL LOC SPB RUSSIA - 23 Mar 16:39:52 [9133] LOC SPB RUSSIA 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 19 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 19 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL NDL 230K,TCP,BINKP - 23 Mar 16:39:52 [9133] NDL 230K,TCP,BINKP 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 37 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 37 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL TIME Wed, 23 Mar 2016 16:39:49 +0300 - 23 Mar 16:39:52 [9133] TIME Wed, 23 Mar 2016 16:39:49 +0300 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 34 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 34 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL VER binkd/1.1a-27/Win32 binkp/1.1 - 23 Mar 16:39:52 [9133] VER binkd/1.1a-27/Win32 binkp/1.1 23 Mar 16:39:52 [9133] remote uses binkp v.1.1 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 18 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 18 (msg) 23 Mar 16:39:52 [9133] rcvd msg ADR 100:0/1@metiznet 23 Mar 16:39:52 [9133] created /var/spool/ftn/outb/metiznet/00000001.bsy + 23 Mar 16:39:52 [9133] addr: 100:0/1@metiznet 23 Mar 16:39:52 [9133] Remote IP not checked 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 21 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 21 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL OPT NDA EXTCMD CRYPT - 23 Mar 16:39:52 [9133] OPT NDA EXTCMD CRYPT + 23 Mar 16:39:52 [9133] Remote supports asymmetric ND mode + 23 Mar 16:39:52 [9133] Remote supports EXTCMD mode + 23 Mar 16:39:52 [9133] Remote requests CRYPT mode 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 8 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 8 (msg) 23 Mar 16:39:52 [9133] rcvd msg NUL TRF 0 4 - 23 Mar 16:39:52 [9133] TRF 0 4 + 23 Mar 16:39:52 [9133] Remote has 0b of mail and 4b of files for us 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 42 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 42 (msg) 23 Mar 16:39:52 [9133] rcvd msg PWD CRAM-MD5-4571d78dada0a88481158d1bfe1f766f 23 Mar 16:39:52 [9133] send message NUL TRF 0 0 23 Mar 16:39:52 [9133] send message NUL OPT EXTCMD 23 Mar 16:39:52 [9133] send message OK non-secure 23 Mar 16:39:52 [9133] send message EOB 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=0, w=1) 23 Mar 16:39:52 [9133] put next msg to obuf, 10 23 Mar 16:39:52 [9133] put next msg to obuf, 13 23 Mar 16:39:52 [9133] put next msg to obuf, 13 23 Mar 16:39:52 [9133] put next msg to obuf, 3 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=0, w=1) 23 Mar 16:39:52 [9133] sending 39 byte(s) 23 Mar 16:39:52 [9133] send() done, rc=39 23 Mar 16:39:52 [9133] data sent 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 19 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 19 (msg) 23 Mar 16:39:52 [9133] rcvd msg FILE 2.2 4 1458740382 0 23 Mar 16:39:52 [9133] file not found, trying to create a tmpname - 23 Mar 16:39:52 [9133] receiving 2.2 (4 byte(s), off 0) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 4 (data) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 4 (data) 23 Mar 16:39:52 [9133] lowercase filename 23 Mar 16:39:52 [9133] perl_after_recv(), perl=0xb86f0b38 23 Mar 16:39:52 [9133] perl_setup_session(), perl context 0xb86f0b38 23 Mar 16:39:52 [9133] perl_setup_session() end 23 Mar 16:39:52 [9133] perl_setup_queue() 23 Mar 16:39:52 [9133] perl_setup_queue() end - 23 Mar 16:39:52 [9133] HOOK after recv 23 Mar 16:39:52 [9133] perl_refresh_queue() 23 Mar 16:39:52 [9133] perl_refresh_queue() end 23 Mar 16:39:52 [9133] perl_after_recv() end ? 23 Mar 16:39:52 [9133] 2.2 -> /var/spool/ftn/inb/2.2 (overwrited) 23 Mar 16:39:52 [9133] unlinked `/var/spool/ftn/inco/913bc134.hr' + 23 Mar 16:39:52 [9133] rcvd: 2.2 (4, 4.00 CPS, 100:0/1@metiznet) 23 Mar 16:39:52 [9133] send message GOT 2.2 4 1458740382 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=0, w=1) 23 Mar 16:39:52 [9133] put next msg to obuf, 19 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=0, w=1) 23 Mar 16:39:52 [9133] sending 19 byte(s) 23 Mar 16:39:52 [9133] send() done, rc=19 23 Mar 16:39:52 [9133] data sent 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] recvd hdr: 1 (msg) 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 1 (r=1, w=0) 23 Mar 16:39:52 [9133] got block: 1 (msg) 23 Mar 16:39:52 [9133] rcvd msg EOB 23 Mar 16:39:52 [9133] there were 4 msgs in this batch 23 Mar 16:39:52 [9133] send message EOB 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 2 (r=1, w=1) 23 Mar 16:39:52 [9133] recvd hdr: 1 (msg) 23 Mar 16:39:52 [9133] put next msg to obuf, 3 23 Mar 16:39:52 [9133] tv.tv_sec=20, tv.tv_usec=0 23 Mar 16:39:52 [9133] selected 2 (r=1, w=1) 23 Mar 16:39:52 [9133] got block: 1 (msg) 23 Mar 16:39:52 [9133] rcvd msg EOB 23 Mar 16:39:52 [9133] sending 3 byte(s) 23 Mar 16:39:52 [9133] send() done, rc=3 23 Mar 16:39:52 [9133] data sent 23 Mar 16:39:52 [9133] there were 2 msgs in this batch 23 Mar 16:39:52 [9133] ND_set_status: unknown address for '' + 23 Mar 16:39:52 [9133] done (from 100:0/1@metiznet, OK, S/R: 0/1 (0/4 bytes)) 23 Mar 16:39:52 [9133] processing kill list 23 Mar 16:39:52 [9133] unlinked `/var/spool/ftn/outb/metiznet/00000001.bsy' ? 23 Mar 16:39:52 [9133] Perl error: Modification of a read-only value attempted. 23 Mar 16:39:52 [9133] exitfunc() 23 Mar 16:39:52 [9133] Closing server socket # 3 23 Mar 16:39:52 [9133] Closing server socket # 4 23 Mar 16:39:52 [9133] bsy_remove_all: done 23 Mar 16:39:52 [9126] rc(9133)=11 -- System Information: Debian Release: 8.3 APT prefers stable-updates APT policy: (500, 'stable-updates'), (500, 'stable') Architecture: i386 (i686) Kernel: Linux 3.16.0-4-686-pae (SMP w/1 CPU core) Locale: LANG=ru_RU.UTF-8, LC_CTYPE=ru_RU.UTF-8 (charmap=UTF-8) Shell: /bin/sh linked to /bin/dash Init: systemd (via /run/systemd/system) Versions of packages binkd depends on: ii adduser 3.113+nmu3 ii init-system-helpers 1.22 ii libc6 2.19-18+deb8u3 ii libperl5.20 5.20.2-3+deb8u4 ii perl 5.20.2-3+deb8u4 binkd recommends no packages. binkd suggests no packages. -- Configuration Files: /etc/binkd/binkd.cfg changed: log /var/log/binkd/binkd loglevel 9 domain metiznet /var/spool/ftn/outb/metiznet 100 domain metizi.net alias-for metiznet address 100:0/200.0@metiznet sysname "Ivan's BBS" location "SPB, Russia" sysop "Ivan Ivanov" nodeinfo 115200,TCP,BINKP conlog 4 timeout 20 connect-timeout 90 call-delay 10 rescan-delay 30 try 10 hold 30m percents printq pid-file /run/ftn/binkd.pid inbound /var/spool/ftn/inb inbound-nonsecure /var/spool/ftn/inb temp-inbound /var/spool/ftn/inco minfree 2048 minfree-nonsecure 2048 kill-dup-partial-files kill-old-partial-files 12h kill-old-bsy 6h root-domain metizi.net filebox /var/spool/ftn/boxes prescan overwrite * inboundcase lower perl-hooks /etc/binkd/test.pl /etc/binkd/binkd.inc empty /etc/binkd/test.pl sub on_start { Log('binkd started'); return 0; }; sub after_recv { Log('HOOK after recv'); return 0; }; -- no debconf information