ifcico fault with errno 5

Wolfgang Grueneberg (wolfgang@wog.han.de)
Mon, 21 Jul 1997 14:36:11 +0200

Hello!

With the suggestions from this mailing list I could built binarys that
run. But ifcico doesn't run without errors. The debug file follows:

---------------------------------------------------------------------------
start ifcico ver 2.8e of Sun Apr 28 18:47:53 1996, verbose 0x000b3ffe
callist entry "f2.n305.z49"
uid=0, euid=0
creating directory tree for "/var/spool/fnet/inbound/tmp/"
mkdir("/var") errno 17
mkdir("/var/spool") errno 17
mkdir("/var/spool/fnet") errno 17
mkdir("/var/spool/fnet/inbound") errno 17
mkdir("/var/spool/fnet/inbound/tmp") errno 17
getnlent for 49:305/2
Initialize 2 nodelists
try "/var/spool/fnet/nodelist/nodelist.192" nodelist
opened nodelist "/var/spool/fnet/nodelist/nodelist.192"
try "/var/spool/fnet/nodelist/dsnnlist.178" nodelist
opened nodelist "/var/spool/fnet/nodelist/dsnnlist.178"
nodelist: 0: fidonet 08076f80
nodelist: 1: DSN 08076000
Trying open existing "/var/spool/fnet/nodelist/index"
WARNING: nodelist index needs to be rebuilt with "ifindex"
found 1 entries
probable match with domain "DSN"
Nodelist line: "Hub,2,GOETHE-BOX Hannover,Hannover GER,Rainer
Suppa,49-511-1687632,9600,CM,XX,V32B,V42B,V34"
getnlent: type 3, pflag=8
getnlent: name GOETHE-BOX Hannover
getnlent: location Hannover GER
getnlent: sysop Rainer Suppa
getnlent: phone 49-511-1687632
getnlent: speed 9600
getnlent: flags 0xc0001ec1
try locking node 49:305/2@DSN
creating directory tree for "/var/spool/fnet/dsn/aa4317"
mkdir("/var") errno 17
mkdir("/var/spool") errno 17
mkdir("/var/spool/fnet") errno 17
mkdir("/var/spool/fnet/dsn") errno 17
created lock OK
check expression "(!CM) & time Any0700-0200"
YY_INPUT "(!CM) & time Any0700-0200" (25) avail, 8192 reqd
Ident: "CM"
flagfor "CM"
ident 1
flag 1
match: 1
elem.expr 1
not.expr 1
backeted.expr 0
Timestr: "Any0700-0200"
chkday: does day 6 match spec -1 ?
chktime: is 13:04 between 07:00 and 02:00 ?
YY_INPUT unavail, 8192 reqd
timelem 1
time 1
elem.expr 1
log.expr 0 285 1
logic: 0 285 1
fulline: return 0
checking result is "false"
options: Call Hold PUA WaZOO EMSI Freqs Zmodem ZedZap Janus Hydra Tcp
calling 49:305/2@DSN (GOETHE-BOX Hannover, phone 49-511-1687632)
try opening port "cua1" at 38400
Trying to create /var/lock/LCK..cua1 for 4317
lock result 0 (errno 17)
try open
after open rc=0
set tty raw
savetios.c_iflag=0x00000500
savetios.c_oflag=0x00000005
savetios.c_cflag=0x00000cbd
savetios.c_lflag=0x00008a3b
savetios.c_cc="\003\034\025\004\000\001\000\021\023\032\000\022\017\027\026\000\000s"
file flags: stdin: 0x0800, stdout: 0x0801
return to blocking mode
file flags: stdin: 0x0000, stdout: 0x0001
dialing 49-511-1687632
send_str "ATZX3\r"
chat got 'A'
chat got 'T'
chat got 'Z'
chat got 'X'
chat got '3'
chat got '\r'
chat got '\r'
chat got '\n'
chat got 'O'
chat got 'K'
chat got "OK", continue
send_str "ATDP0\T\r"
chat got '\r'
chat got '\n'
chat got 'A'
chat got 'T'
chat got 'D'
chat got 'P'
chat got '0'
chat got '1'
chat got '6'
chat got '8'
chat got '7'
chat got '6'
chat got '3'
chat got '2'
chat got '\r'
chat got '\r'
chat got '\n'
chat got 'C'
chat got 'O'
chat got 'N'
chat got 'N'
chat got 'E'
chat got 'C'
chat got 'T'
chat got ' '
chat got '3'
chat got '8'
chat got '4'
chat got '0'
chat got '0'
chat got "CONNECT 38400", continue
setting port "/dev/cua1" non-local
start master session type 0 with 49:305/2@DSN
tidy_falist beginning from <null>
statemachine tx_define_type start skipjunk (0)
timeout
timeout
timeout
Intro: "D'Bridge EMAIL System 1.58/020147... Copyright 1987-1993 by
Chris Irwin"
Intro: "Software license registered to Niedersaechsisches Schulnetz"
got '' reading intro
got '' reading intro
check "EMSI_REQA77E" for being EMSI request
statemachine tx_define_type exit success (1)
start outbound EMSI session
local lcodes 0x0001, protos 0x0006, opts 0x0008
statemachine txemsi start senddata (0)
bestaka_s for 49:305/2@DSN
addr 2:241/1016@fidonet metric 5
addr 49:305/701@DSN metric 2
setting best
bestaka_s is 49:305/701@DSN
prepared: "EMSI_DAT00EE{EMSI}{49:305/701@DSN
2:241/1016@fidonet}{NSN}{8N1,PUA}{ZAP,ZMO,XMA}{FE}{ifcico}{2.8e}{Sun Apr
28 18:47:53 1996}{TRX#}{[33D0BB99]}{IDENT}{[== WG-Box Hannover
==][Hannover Germany][Wolfgang
Grueneberg][49-511-6138291][14400][XA,V32B,V42B]}"
got '' from remote
got '' from remote
txemsi got: " Bitte 2x E"
got '' from remote
got '' from remote
got '' from remote
txemsi got: "EMSI_REQA77E"
got '' from remote
got '' from remote
txemsi got: " Bitte 2x E"
got '' from remote
txemsi got: "EMSI_REQA77E"
txemsi got: "EMSI_ACKA490"
statemachine txemsi exit success (1)
statemachine rxemsi start checkpkt (4)
rxemsi ignores packet "EMSI_REQA77E"
rxemsi got: "EMSI_ACKA490"
rxemsi ignores packet "EMSI_ACKA490"
rxemsi got: "EMSI_DAT0101"
try get emsi_dat packet starting with "EMSI_DAT0101"
got '{'
got 'E'
got 'M'
got 'S'
got 'I'
got '}'
got '{'
got '4'
got '9'
got ':'
got '3'
got '0'
got '5'
got '/'
got '2'
got '}'
got '{'
got 'N'
got 'S'
got 'N'
got '}'
got '{'
got '8'
got 'N'
got '1'
got '}'
got '{'
got 'Z'
got 'A'
got 'P'
got ','
got 'B'
got 'B'
got 'S'
got ','
got 'U'
got 'T'
got 'S'
got '}'
got '{'
got '1'
got 'a'
got '}'
got '{'
got 'D'
got '''
got 'B'
got 'r'
got 'i'
got 'd'
got 'g'
got 'e'
got '}'
got '{'
got '1'
got '.'
got '5'
got '8'
got '}'
got '{'
got '0'
got '2'
got '0'
got '1'
got '4'
got '7'
got '}'
got '{'
got 'X'
got 'M'
got 'I'
got 'T'
got '}'
got '{'
got 'n'
got 'X'
got 'f'
got '!'
got '!'
got '"'
got '!'
got '!'
got '"'
got 'e'
got 'G'
got ' '
got '*'
got '}'
got '{'
got 'S'
got 'D'
got 'C'
got '}'
got '{'
got '['
got 'E'
got 'F'
got '*'
got '!'
got '!'
got '!'
got '*'
got '!'
got '!'
got '!'
got ']'
got '['
got 'E'
got ','
got '-'
got '\'
got '2'
got ':'
got ']'
got '['
got '-'
got '"'
got 'S'
got 'L'
got 'S'
got 'T'
got ']'
got '['
got '+'
got 'F'
got '^'
got '?'
got 'c'
got 'M'
got 'A'
got 'D'
got ']'
got '}'
got '{'
got 'U'
got 'T'
got 'C'
got '}'
got '{'
got ','
got '-'
got '\'
got '2'
got ':'
got '8'
got '&'
got '?'
got ','
got '!'
got '!'
got 'v'
got 'L'
got 'S'
got 'T'
got '}'
got '{'
got 'I'
got 'D'
got 'E'
got 'N'
got 'T'
got '}'
got '{'
got '['
got 'G'
got 'O'
got 'E'
got 'T'
got 'H'
got 'E'
got '-'
got 'B'
got 'O'
got 'X'
got ' '
got 'H'
got 'a'
got 'n'
got 'n'
got 'o'
got 'v'
got 'e'
got 'r'
got ']'
got '['
got '3'
got '0'
got '1'
got '6'
got '7'
got ' '
got 'H'
got 'a'
got 'n'
got 'n'
got 'o'
got 'v'
got 'e'
got 'r'
got '_'
got 'G'
got 'E'
got 'R'
got ']'
got '['
got 'R'
got 'a'
got 'i'
got 'n'
got 'e'
got 'r'
got ' '
got 'S'
got 'u'
got 'p'
got 'p'
got 'a'
got ']'
got '['
got '4'
got '9'
got '-'
got '0'
got '5'
got '1'
got '1'
got '-'
got '1'
got '6'
got '8'
got '7'
got '6'
got '3'
got '2'
got ']'
got '['
got '9'
got '6'
got '0'
got '0'
got ']'
got '['
got 'X'
got 'X'
got ','
got 'C'
got 'M'
got ','
got 'V'
got '3'
got '2'
got ','
got 'V'
got '3'
got '4'
got ']'
got '}'
got '4'
got 'F'
got '8'
got '5'
len 273, databuf
"EMSI_DAT0101{EMSI}{49:305/2}{NSN}{8N1}{ZAP,BBS,UTS}{1a}{D'Bridge}{1.58}{020147}{XMIT}{nXf!!"!!"eG
*}{SDC}{[EF*!!!*!!!][E,-\2:][-"SLST][+F^?cMAD]}{UTC}{,-\2:8&?,!!vLST}{IDENT}{[GOETHE-BOX
Hannover][30167 Hannover_GER][Rainer
Suppa][49-0511-1687632][9600][XX,CM,V32,V34]}4F85"
got data packet:
"{EMSI}{49:305/2}{NSN}{8N1}{ZAP,BBS,UTS}{1a}{D'Bridge}{1.58}{020147}{XMIT}{nXf!!"!!"eG
*}{SDC}{[EF*!!!*!!!][E,-\2:][-"SLST][+F^?cMAD]}{UTC}{,-\2:8&?,!!vLST}{IDENT}{[GOETHE-BOX
Hannover][30167 Hannover_GER][Rainer
Suppa][49-0511-1687632][9600][XX,CM,V32,V34]}"
tidy_falist beginning from f2.n305
remote address: 49:305/2
try locking node 49:305/2
creating directory tree for "/var/spool/fnet/dsn/aa4317"
mkdir("/var") errno 17
mkdir("/var/spool") errno 17
mkdir("/var/spool/fnet") errno 17
mkdir("/var/spool/fnet/dsn") errno 17
.bsy file present, check staleness
opened bsy file for pid 4317
process active, lock failed
remote password: NSN
unrecognized EMSI proto/option code: "BBS"
unrecognized EMSI proto/option code: "UTS"
remote uses: D'Bridge [1a] version 1.58/020147
remote tag: "XMIT" value: "nXf!!"!!"eG *"
remote tag: "SDC" value: "[EF*!!!*!!!][E,-][-"SLST][+F^?cMAD]"
remote tag: "UTC" value: ",-8&?,!!vLST"
remote system: GOETHE-BOX Hannover
remote location: 30167 Hannover_GER
remote operator: Rainer Suppa
remote phone: 49-0511-1687632
remote baud: 9600
remote flags: XX,CM,V32,V34
statemachine rxemsi exit success (1)
remote lcodes 0x0000, protos 0x0002, opts 0x0000
start txwazoo transfer
create_filelist(49:305/2,"co",0)
check_flo("/var/spool/fnet/dsn/01310002.clo")
no flo file
add_list("/var/spool/fnet/dsn/01310002.spl","(null)",3,to end)
check_flo("/var/spool/fnet/dsn/01310002.flo")
no flo file
flist: "/var/spool/fnet/dsn/01310002.spl" -> "(null)" dsp:3 flofp:0
floff:0
start ZedZap send
initsend
zshhdr: f 4 ZRQINIT 0
getzrxinit
zgethdr: B 4 ZRINIT 23000000
remote allowed Rxbuflen=0
Rxbuflen=0 blklen=1024
Txwindow = 0 Txwspac = 0
sendzsinit
leaving sent file "/var/spool/fnet/dsn/01310002.spl"
finsend
timeout
zshhdr: f 4 ZFIN 0
zgethdr: B 4 ZRINIT 23000000
zshhdr: f 4 ZFIN 0
zgethdr: B 4 ZFIN 0
zmodem send rc=0
start ZedZap receive
tryz
zshhdr: f 4 ZRINIT 2b010000
zgethdr: B 4 ZRQINIT 0
zshhdr: f 4 ZRINIT 2b010000
zrbhd32 c=4 crc=2A90D46B
zrbhd32 c=0 crc=DA4A2804
zrbhd32 c=0 crc=7B78E31
zrbhd32 c=0 crc=51D9B7B4
zrbhd32 c=0 crc=CC5DAE22
zrbhd32 c=DD crc=2DCEB223
zrbhd32 c=51 crc=BE26DEA2
zrbhd32 c=A2 crc=BE26DE
zrbhd32 c=33 crc=DEBB20E3
zgethdr: C 4 ZFILE 0
zrdat32: 30 ZCRCW
rzfiles
rzfile
proheader "0000fd45.SA1"
zmodem receive: "0000fd45.SA1" 15266 bytes dated Jul 19 06:23:02 mode 0
openfile("0000fd45.SA1",Jul 19 06:23:02,15266,...)
try fopen("/var/spool/fnet/inbound/tmp/0000fd45.SA1","w")
opened file "/var/spool/fnet/inbound/tmp/0000fd45.SA1" for "w", restart
at 0
zshhdr: f 4 ZRPOS 0
zrbhd32 c=A crc=CD28F96C
zrbhd32 c=0 crc=44C9058A
zrbhd32 c=0 crc=D29A33B
zrbhd32 c=0 crc=B106C087
zrbhd32 c=0 crc=736D1043
zrbhd32 c=BC crc=2D71829D
zrbhd32 c=EF crc=BE266192
zrbhd32 c=92 crc=BE2661
zrbhd32 c=8C crc=DEBB20E3
zgethdr: C 4 ZDATA 0
0 ZMODEM CRC-32
zrdat32: 512 ZCRCG
putsec 512 bytes
512 ZMODEM CRC-32
zrdat32: 512 ZCRCG
putsec 512 bytes
1024 ZMODEM CRC-32
zrdat32: 512 ZCRCG
putsec 512 bytes
1536 ZMODEM CRC-32
zrdat32: 512 ZCRCG
putsec 512 bytes
2048 ZMODEM CRC-32
zrdat32: 1024 ZCRCG
putsec 1024 bytes
3072 ZMODEM CRC-32
zrdat32: 1024 ZCRCG
putsec 1024 bytes
4096 ZMODEM CRC-32
zrdat32: 1024 ZCRCG
putsec 1024 bytes
5120 ZMODEM CRC-32
zrdat32: 1024 ZCRCG
putsec 1024 bytes
6144 ZMODEM CRC-32
zrdat32: 2048 ZCRCG
putsec 2048 bytes
8192 ZMODEM CRC-32
zrdat32: 2048 ZCRCG
putsec 2048 bytes
10240 ZMODEM CRC-32
zrdat32: 2048 ZCRCG
putsec 2048 bytes
12288 ZMODEM CRC-32
zrdat32: 2048 ZCRCG
putsec 2048 bytes
14336 ZMODEM CRC-32
zrdat32: 930 ZCRCE
putsec 930 bytes
zrbhd32 c=B crc=BA2FC9FA
zrbhd32 c=A2 crc=650AF60F
zrbhd32 c=3B crc=21D1FE43
zrbhd32 c=0 crc=EFF4C1D4
zrbhd32 c=0 crc=8151E20C
zrbhd32 c=F3 crc=2D83BE6F
zrbhd32 c=1D crc=BE2693AE
zrbhd32 c=AE crc=BE2693
zrbhd32 c=7E crc=DEBB20E3
zgethdr: C 4 ZEOF 3ba2
closefile(1), for file "/var/spool/fnet/inbound/tmp/0000fd45.SA1"
moving "/var/spool/fnet/inbound/tmp/0000fd45.SA1" ->
"/var/spool/fnet/inbound/0000fd45.SA1"
received 15266 bytes in 10 seconds (1526 cps)
rzfile: normal EOF
tryz
zshhdr: f 4 ZRINIT 2b010000
zgethdr: B 4 ZFIN 0
zshhdr: f 4 ZRINIT 2b010000
zgethdr: B 4 ZFIN 0
ackbibi:
zshhdr: f 4 ZFIN 0
ackbibi got '\021', continue
zshhdr: f 4 ZFIN 0
got SIGHUP
ackbibi got -8, ignore
zmodem receive rc=-1
end txwazoo transfer
try unlocking node 49:305/2
unlinking lock file
setting port "/dev/cua1" local
hanging up
send_str "ATZ\r"
send_str error
errno=5 : I/O error
closing port "/dev/cua1"
tcsetattr(0,TCSAFLUSH,save) return -1
errno=5 : I/O error
call to 49:305/2@DSN failed (rc=11)
0 of 1 calls, maxrc=11
---------------------------------------------------------------------------

The file 0000fd45.SA1 was transfered complety. Why does ifcico report an
I/O error?

Greetings
Wolfgang