> From [EMAIL PROTECTED] Wed Feb 20 16:36:31 2002
> From: "Antony Healey" <[EMAIL PROTECTED]>
> To: <[EMAIL PROTECTED]>
> Subject: Re: LPRng: Printing problems
> Date: Thu, 21 Feb 2002 10:35:25 +1100
>
>
> > > I'm having some difficulty in trying to trace a 'fault' when using the =
> > > newer version of LPRng and ifhp.
> > >
> > > If I attach the printer (an HP 8150dn) to LPRng 3.8.5 and ifhp 3.5.3, =
> > > the job never prints. The logs come back saying "done" etc, but the job
> =
> > > just sits in the queue like it's waiting on some response from the =
> > > printer.
> > >
> > > If I attach the same printer to another queue, running LPRng 3.5.3 and =
> > > ifhp (unknown version) then the job printers straight away. There is no
> =
> > > delay between the job hitting the queue and the printer starting up.
> > >
> > > Has anyone else experienced this, or have any ideas for testing?
> > >
> > > Some details....
> > ...
> >
> > What is your printcap for this printer?
> >
> > Patrick
>
>
> Hi Patrick,
>
> /etc/printcap entry is
>
> .common:
>    :sd=/var/spool/lpd/%P
>    :sh:mx=0:mc=0
>
> kwd-y106-lj8150dn|8150
>    :tc=.common
>    :lp=kwd-y106-lj8150dn%9100
>    :filter=/local/apps/lprng/filters/ifhp
>    :ifhp=model=hp8150
>    :done_jobs=0
>
> Just very basic until I can get past this 'issue'.
>
> Here's the lpq -llll result...
>
> Printer: kwd-y106-lj8150dn@dinadan '8150'
>  Queue: 1 printable job
>  Server: pid 610 active
>  Unspooler: pid 611 active
>  Status: waiting for subserver to exit at 10:29:51.166
>  Status: subserver pid 611 starting at 10:29:51.188
>  Status: accounting at start at 10:29:51.190
>  Status: opening device 'kwd-y106-lj8150dn%9100' at 10:29:51.193
>  Status: printing job 'root@dinadan+609' at 10:29:57.316
>  Status: processing 'dfA609dinadan.cit.uws.edu.au', size 146, format 'f', IF
> filter 'ifhp' at 10:29:57.318
>  Filter_status: using model 'hp8150' at 10:29:57.918
>  Filter_status: pagecount using 'pjl info pagecount' at 10:29:57.963
>  Filter_status: setting up printer at 10:29:57.964
>  Filter_status: getting sync using 'pjl echo' at 10:29:57.964
>  Filter_status: id = "LASERJET 8150" at 10:29:58.855
>  Filter_status: sync done at 10:29:58.909
>  Filter_status: pagecounter 42 after 1 attempts at 10:29:58.910
>  Filter_status: pagecounter 42 at 10:29:58.910
>  Filter_status: sending job file at 10:29:58.919
>  Filter_status: starting transfer at 10:29:58.919
>  Rank   Owner/ID                  Class Job Files                 Size Time
> active root@dinadan+609             A   609 /home/antony/one.ps    146
> 10:29:51
>
> The job will now stay listed as 'active' indefinately.
>
> The closest I've been able to diagnose is that there is some problem with
> lpd sending the job out on STDOUT or with ifhp accepting the job on STDIN.
>
> Physical result is that the printer data light flashes for 10 seconds
> (approx) and then stops. I can get this same result by getting ifhp to
> directly contact the printer (-Tdev=..) while not passing it a file on
> STDIN.
>
> Would love some guidance if possible.
>
> Regards,
> Antony.
> -----
> Unix Systems Administrator
> School of Computing & IT
> University of Western Sydney
> Phone: (02) 4736 0771
> Fax: (02) 4736 0770
>
> Programmer (n): One who makes the lies the salesman told come true.
>

This is VERY interesting.  Here is the sequence of events:

  Filter_status: using model 'hp8150' at 10:29:57.918
    - we have a TCP/IP connection 
  Filter_status: pagecount using 'pjl info pagecount' at 10:29:57.963
    - we want pagecount, etc.
  Filter_status: setting up printer at 10:29:57.964
  Filter_status: getting sync using 'pjl echo' at 10:29:57.964
    - we are going to use PJL to see if the printer is alive
  Filter_status: id = "LASERJET 8150" at 10:29:58.855
    - it is alive.  It is also reporting itself as a LASERJET 8150
      (this is nice to know...  as I have had some people trying to
      use the wrong commands for a printer...)
  Filter_status: sync done at 10:29:58.909
    - And the printer is now in a sane state
  Filter_status: pagecounter 42 after 1 attempts at 10:29:58.910
    - The pagecounter value is 42.  Ummm... that is really odd,
      such a low page count...  New printer?  probably.
      And 42?  Life, the Universe, and Everything?  Hmm...
  Filter_status: pagecounter 42 at 10:29:58.910
  Filter_status: sending job file at 10:29:58.919
    - OK, we now rev up the data transfer
  Filter_status: starting transfer at 10:29:58.919
    - and it stops HARD...

  There should be some 'getting 80% ...' stuff.

Possiblity 1:  the printer is dying.
  Don't laugh, bad RAM did this to one system.

OK,  we can now debug this brutally.

cd .../ifhp/UTILS    #
cp /tmp/one.ps /tmp  # get this test file from the ifhp distribution

cp sendhp.sh /tmp

vi /tmp/sendhp.sh

 -- edit the /tmp/sendhp.sh file
#!/bin/sh
out=10.0.0.31%9100    # set the IP address of your printer
#debug=debug=4
file=/tmp/one.ps
model=model=hp8150
cp /dev/null /tmp/out
/usr/libexec/filters/ifhp -Tdev=$out,trace,$debug,$model <$file 2>&1 | tee /tmp/log

^^^^ set path to ifhp

Now run this:

sh /tmp/sendhp.sh

And you should see:

ifhp 10:17:50.349 [90025] main: using model 'hp8150'
ifhp 10:17:50.355 [90025] Check_pagecount: pagecount using 'pjl info pagecount'
ifhp 10:17:50.355 [90025] Process_job: setting up printer
ifhp 10:17:50.355 [90025] Do_sync: getting sync using 'pjl echo'
ifhp 10:17:51.978 [90025] Pr_status: id = "LASERJET 8150"
ifhp 10:17:52.078 [90025] Do_sync: sync done
ifhp 10:17:52.082 [90025] Do_pagecount: pagecounter 1126 after 1 attempts
ifhp 10:17:52.083 [90025] Do_accounting: pagecounter 1126
ifhp 10:17:52.083 [90025] Process_job: sending job file
ifhp 10:17:52.083 [90025] Send_job: starting transfer
ifhp 10:17:52.083 [90025] Send_job: initial job type 'POSTSCRIPT'
ifhp 10:17:52.083 [90025] Send_job: decoded job type 'POSTSCRIPT'
ifhp 10:17:52.083 [90025] Send_job: job type 'POSTSCRIPT'
ifhp 10:17:52.083 [90025] Send_job: transferring 145 bytes
ifhp 10:17:52.083 [90025] Send_job: 100 percent done
ifhp 10:17:52.083 [90025] Process_job: sent job file
ifhp 10:17:52.084 [90025] Do_waitend: getting end using 'pjl job/eoj'
ifhp 10:18:04.196 [90025] Do_waitend: end of job detected
ifhp 10:18:05.875 [90025] Do_pagecount: pagecounter 1127 after 1 attempts
ifhp 10:18:05.876 [90025] Do_accounting: pagecounter 1127, pages 1
ifhp 10:18:05.876 [90025] Process_job: done

If this works, then try one of the files you are trying to print:

...
file=/this.file.to.print

and repeat.

Patrick Powell                 Astart Technologies,
[EMAIL PROTECTED]            9475 Chesapeake Drive, Suite D,
Network and System             San Diego, CA 92123
  Consulting                   858-874-6543 FAX 858-279-8424 
LPRng - Print Spooler (http://www.lprng.com)

-----------------------------------------------------------------------------
YOU MUST BE A LIST MEMBER IN ORDER TO POST TO THE LPRNG MAILING LIST
The address you post from MUST be your subscription address

If you need help, send email to [EMAIL PROTECTED] (or lprng-requests
or lprng-digest-requests) with the word 'help' in the body.  For the impatient,
to subscribe to a list with name LIST,  send mail to [EMAIL PROTECTED]
with:                           | example:
subscribe LIST <mailaddr>       |  subscribe lprng-digest [EMAIL PROTECTED]
unsubscribe LIST <mailaddr>     |  unsubscribe lprng [EMAIL PROTECTED]

If you have major problems,  send email to [EMAIL PROTECTED] with the word
LPRNGLIST in the SUBJECT line.
-----------------------------------------------------------------------------

Reply via email to