v5.1tru64unix LPD only functions once and then loops

From: Rainer Wolf <rainer.wolf_at_rz.uni-ulm.de>
Date: Thu, 24 Jul 2003 15:18:13 +0200

Hello ,
i have a problem with the lpd server : a printfile is queued correctly but
at the time the print has actually finished and also the queue-entry
is normally disappearing ... the lpd is saying about some bad-file-number.

Somehow the lpd-child does not finish correctly and is starting to loop
with nearly 100% cpu constant using.

The next print-job in the same queue then will not start process
as usual and only a reset/start can help.
It seems that the lpd ha a bug .
My question: where can I get a funcioning lpd for a
DECalpha 433au running Tru64Unix V5.1
uname shows :
OSF1 orkus V5.1 732 alpha
The current version of lpd shows:
orkus:.../patch_kit# ls -l /usr/lbin/lpd
-rws--x--x 1 root bin 158880 Apr 13 2001 /usr/lbin/lpd
orkus:.../patch_kit# strings /usr/lbin/lpd |grep -i revision
_at_(#)$RCSfile: crt0.s,v $ $Revision: 1.1.26.2 $ (DEC) $Date: 1997/04/03 22:25:40 $
orkus:.../patch_kit#

I changed allready modified all protections and even changed the
spooling filesystem
Has someone seen this ? ... in the mailing-list i found
some similar questions but no summary ... thanks in advance for any help

Greetings Rainer

-- 
-------------------------------------------------------------------------------
Rainer Wolf                                   mail:   rainer.wolf_at_rz.uni-ulm.de
Kommunikations und Informationszentrum        tel/fax: ++49 731 50-22482/222471
Abt. Infrastruktur, Uni Ulm                   web:    http://www.uni-ulm.de/urz
....................................
Jul 24 15:06:33 orkus lpd[15974]: NOTICE -- lpd: MASTER DAEMON STARTED
Jul 24 15:06:33 orkus lpd[15974]: DEBUG -- entering startup()
Jul 24 15:06:33 orkus lpd[15974]: DEBUG -- entering useRemoteNode(/spool/lpd/r5408urzlaser, lock, localhost)
Jul 24 15:06:33 orkus lpd[15974]: DEBUG -- Leaving startup()
Jul 24 15:06:33 orkus lpd[15974]: DEBUG -- FD_SET on funix, max_fds: 5
Jul 24 15:06:33 orkus lpd[15974]: DEBUG -- FD_SET on finet, max_fds: 6
Jul 24 15:06:33 orkus lpd[15974]: DEBUG -- lpd: entering main loop
Jul 24 15:07:38 orkus lpd[15974]: DEBUG -- return from select(), read network socket
Jul 24 15:07:38 orkus lpd[15974]: DEBUG -- lpd: accept on unix socket
Jul 24 15:07:38 orkus lpd[15974]: DEBUG -- fork_with_retries: child pid: 16105
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- chkhost: entered chkhost()
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- chkhost: checking ahost=somehost.rz.uni-ulm.de, domain=.rz.uni-ulm.de, baselen=6
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- chkhost: connection to printer is not allowed in /etc/hosts.equiv
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- chkhost: connection to printer is ok in /etc/hosts.lpd
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- entering doit()
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- somehost.rz.uni-ulm.de requests recvjob urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- lpd/doit: got RECVJOB request for printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- readjob: case 2
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- About to read control file for job: 166, from node: sponsl.rz.uni-ulm.de
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- printjob: entered printjob, printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- printjob - closed file descriptor: 5
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- printjob - closed file descriptor: 4
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- Entering init()
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- printjob: sent ACK, printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- STB CHECK, sd_stb.st_mode: 40755, after stat of SD
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- STB CHECK, lo_stb.st_mode: 100644, after stat of LO
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- lock file created, lfd: 4
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- printjob: got lock on file 'lock', printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- printjob: created file /spool/lpd/r5408urzlaser/.daemon_running_on_orkus, printer
urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- about to check reset queue flag, lo_stb.st_mode: 100644
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- STB CHECK, q_stb.st_mode: 100660, after stat of q->q_name
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- openpr: entered openpr(), printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- openpr: in /etc/printcap LP is /dev/null, printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- openpr: BEFORE attempt open LP /dev/null, printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- openpr: AFTER attempt open LP /dev/null, printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- openpr: opened LP /dev/null, printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- openpr: LP==/dev/null and no flock, printer urzlaser_r5408
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- writeStatus: status file update, printer urzlaser_r5408: Thu Jul 24 15:07:38 2003:
urzlaser_r5408 is ready and printing
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- Entering printit(cfA166somehost.rz.uni-ulm.de)
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- writeStatus: status file update, printer urzlaser_r5408: Thu Jul 24 15:07:38 2003:
Attempting to print dfA166SOMEHOST
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- entering print(f, dfA166SOMEHOST)
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- about to leave dofork() as pid: 16105
Jul 24 15:07:38 orkus lpd[16105]: DEBUG -- child_wait: start wait for child 16107
Jul 24 15:07:38 orkus lpd[16107]: DEBUG -- about to leave dofork() as pid: 16107
Jul 24 15:07:48 orkus lpd[16105]: DEBUG -- child_wait: finished wait for child 16107
Jul 24 15:07:48 orkus lpd[16105]: DEBUG -- writeStatus: status file update, printer urzlaser_r5408: Thu Jul 24 15:07:48 2003:
Notifying user...
Jul 24 15:07:48 orkus lpd[16105]: DEBUG -- writeStatus: status file update, printer urzlaser_r5408: Thu Jul 24 15:07:48 2003:
urzlaser_r5408 is ready and printing
Jul 24 15:07:48 orkus lpd[16105]: DEBUG -- STB CHECK, lo_stb.st_mode: 100644, after stat of lfd
Jul 24 15:07:48 orkus lpd[16105]: DEBUG -- writeStatus: status file update, printer urzlaser_r5408: Thu Jul 24 15:07:48 2003: 
Jul 24 15:07:48 orkus lpd[16105]: DEBUG -- read_some_chars: read() failed, error: Bad file number
Jul 24 15:08:18 orkus last message repeated 121878 times
orkus:...//#

Received on Thu Jul 24 2003 - 13:29:46 NZST