Printer Queues hanging using TCP/IP

From: mark.hickey@talk21.com
Date: Wed Aug 14 2002 - 13:43:44 EDT


I have a number of sites across the UK, printing is via a Wide Area Network and Decserver 90TL terminal servers using TCP/IP, the problem seems to be random across different sites.

Typically what I see when a queue hangs is that the user reports that the printer is online and I see the following output;

europa ->lpc status glaprint7
glaprint7:
        printer is on device '@gla11/port1' speed -1
        queuing is enabled
        printing is enabled
        17 entries in spool area
        Tue Aug 6 14:25:33 2002: Attempting to print dfA824europa

europa ->cat /var/spool/lpd42/lock
6408
cfA824europa

europa ->ps -ef | grep 6408
root 6408 3036 0.0 14:23:58 ?? 0:00.18 /usr/lbin/lpd
daemon 32492 6408 0.0 14:23:58 ?? 0:00.01 la280of -w132 -l66
hickeym 26779 5313 0.2 15:26:17 ttyq3 0:00.01 grep 6408
europa ->ps -ef | grep 32492
daemon 32492 6408 0.0 14:23:58 ?? 0:00.01 la280of -w132 -l66
hickeym 29469 5313 0.4 15:26:32 ttyq3 0:00.02 grep 32492

europa ->netstat | grep gla11
tcp 15 0 europa.1080 gla11.port1 ESTABLISHED

europa ->telnet gla11
Trying 10.11.4.11...
Connected to gla11.
Escape character is '^]'.

#

DECserver 90TL Communications Server V1.1C (BL46A-13) - LAT V5.1

(c) Copyright 1996, Digital Equipment Corporation - All Rights Reserved

Please type HELP if you need assistance

Enter username> mfh

Local> sh port all

Port Access Status Services Offered

  1 Remote Connected Listener 2001
  2 Remote Idle Listener 2002
  3 Remote Idle Listener 2003
  4 Remote Idle Listener 2004
  5 Remote Idle Listener 2005
  6 Remote Idle Listener 2006
  7 Remote Idle Listener 2007
  8 Remote Idle Listener 2008

A cutdown version of the lpr.log shows the following;

Aug 6 14:25:23 europa lpd[6408]: DEBUG -- writeStatus: status file update, printer glaprint7: Tue Aug 6 14:25:23 2002: Attempting
to print dfA823europa
Aug 6 14:25:23 europa lpd[6408]: DEBUG -- child_wait: start wait for child 32492
Aug 6 14:25:23 europa lpd[6408]: DEBUG -- child_wait: finished wait for child 32492
Aug 6 14:25:23 europa lpd[6408]: DEBUG -- about to leave dofork() as pid: 6408
Aug 6 14:25:23 europa lpd[6408]: DEBUG -- child_wait: start wait for child 27909
Aug 6 14:25:33 europa lpd[6408]: DEBUG -- child_wait: finished wait for child 27909
Aug 6 14:25:33 europa lpd[6408]: DEBUG -- writeStatus: status file update, printer glaprint7: Tue Aug 6 14:25:33 2002: Notifying user...
Aug 6 14:25:33 europa lpd[6408]: DEBUG -- writeStatus: status file update, printer glaprint7: Tue Aug 6 14:25:33 2002: glaprint7 is ready and printing
Aug 6 14:25:33 europa lpd[6408]: DEBUG -- Entering printit(cfA824europa)
Aug 6 14:25:33 europa lpd[6408]: DEBUG -- writeStatus: status file update, printer glaprint7: Tue Aug 6 14:25:33 2002: Attempting to print dfA824europa
Aug 6 14:25:33 europa lpd[6408]: DEBUG -- child_wait: start wait for child 32492

Then ran an lpc restart glaprint7

Aug 6 15:42:11 europa lpd[6408]: INFO -- abort_signal: received signal 15, aborting current job
Aug 6 15:42:16 europa lpd[6408]: DEBUG -- writeStatus: status file update, printer glaprint7: Tue Aug 6 15:42:16 2002:
Aug 6 15:42:16 europa lpd[6408]: INFO -- abort_signal: exiting...
Aug 6 15:42:16 europa lpd[6408]: INFO -- printjob_exit: breaking promise to process all queued print jobs since this daemon was asked to exit now, printer glaprint7

If anyone has any tips or advice, please drop me a line.

Regards

Mark Hickey
Systems Administrator

Mark Hickey
Tel. 01440-710677

--------------------
talk21 your FREE portable and private address on the net at http://www.talk21.com



This archive was generated by hypermail 2.1.7 : Sat Apr 12 2008 - 10:48:49 EDT