[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

CUPS renders but hangs with Compaq IJ750



Hello list,

I've got a Comapaq (Lexmark) IJ750 (parallel-port inkjet), and am
trying to get it to print with cupsys. If I use lpr to print a
postscript file, the command returns successfully, the cupsys error
log doesn't show any major problems, but the printer just sits
there. Nothing happens.

The kernel has no trouble detecting the printer:

blue:/home/joe# cat /proc/sys/dev/parport/parport0/autoprobe
CLASS:PRINTER;
MODEL:Inkjet 4099;
MANUFACTURER:Lexmark;
DESCRIPTION:Inkjet 4099;
COMMAND SET:LOWENDLEXCPD;

And the job shows up in the queue:

blue:/home/joe# lpq 
ij is ready and printing
Rank    Owner   Job     File(s)                         Total Size
active  root    18      test.ps                         12288 bytes

I've noticed one unusual point: the process table shows entries
corresponding to print jobs, even ones that I've removed with lprm:

blue:/home/joe# ps auxw|grep parallel
root       657  0.0  0.4  2088  516 ?        S    07:26   0:00 parallel:/dev/lp0 16 root sig.ps 1 
root       693  0.0  0.4  2088  512 ?        S    07:27   0:00 parallel:/dev/lp0 18 root test.ps 1 
root       721  0.0  0.3  1292  424 pts/0    R    07:34   0:00 grep parallel

(sig.ps was lprmed earlier)

Is there some way I can force cupsys to tell me where the job is
wedged? I suspect something's preventing the data from reaching the
printer, but I'm not sure how to diagnose it. Any suggestions would be
appreciated.

Thanks in advance,

--Joe





Here's the cupsys error log for that entry:

D [27/Aug/2003:07:27:28 -0400] AcceptClient() 5 from localhost:631.
D [27/Aug/2003:07:27:28 -0400] ReadClient() 5 POST / HTTP/1.1
D [27/Aug/2003:07:27:28 -0400] ProcessIPPRequest: 5 status_code=1
D [27/Aug/2003:07:27:28 -0400] CloseClient() 5
D [27/Aug/2003:07:27:28 -0400] AcceptClient() 5 from localhost:631.
D [27/Aug/2003:07:27:28 -0400] ReadClient() 5 POST / HTTP/1.1
D [27/Aug/2003:07:27:28 -0400] ProcessIPPRequest: 5 status_code=1
D [27/Aug/2003:07:27:28 -0400] CloseClient() 5
D [27/Aug/2003:07:27:28 -0400] AcceptClient() 5 from localhost:631.
D [27/Aug/2003:07:27:28 -0400] ReadClient() 5 POST / HTTP/1.1
D [27/Aug/2003:07:27:28 -0400] ProcessIPPRequest: 5 status_code=0
D [27/Aug/2003:07:27:28 -0400] ReadClient() 5 POST /printers/ij HTTP/1.1
D [27/Aug/2003:07:27:28 -0400] print_job: auto-typing file...
D [27/Aug/2003:07:27:28 -0400] print_job: request file type is application/postscript.
D [27/Aug/2003:07:27:28 -0400] check_quotas: requesting-user-name = 'root'
D [27/Aug/2003:07:27:28 -0400] print_job: requesting-user-name = 'root'
I [27/Aug/2003:07:27:28 -0400] Adding start banner page "none" to job 18.
I [27/Aug/2003:07:27:28 -0400] Adding end banner page "none" to job 18.
I [27/Aug/2003:07:27:28 -0400] Job 18 queued on 'ij' by 'root'.
D [27/Aug/2003:07:27:28 -0400] Job 18 hold_until = 0
D [27/Aug/2003:07:27:28 -0400] StartJob(18, 0x8086050)
D [27/Aug/2003:07:27:28 -0400] StartJob() id = 18, file = 0/1
D [27/Aug/2003:07:27:28 -0400] job-sheets=none,none
D [27/Aug/2003:07:27:28 -0400] banner_page = 0
D [27/Aug/2003:07:27:28 -0400] StartJob: argv = "ij","18","root","test.ps","1","","/var/spool/cups/d00018-001"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[2]="USER=root"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[3]="CHARSET=iso-8859-1"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[4]="LANG=en"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[5]="TZ=America/New_York"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[6]="PPD=/etc/cups/ppd/ij.ppd"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[7]="CUPS_SERVERROOT=/etc/cups"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[8]="RIP_MAX_CACHE=8m"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[9]="TMPDIR=/var/spool/cups/tmp"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[10]="CONTENT_TYPE=application/postscript"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[11]="DEVICE_URI=parallel:/dev/lp0"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[12]="PRINTER=ij"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[13]="CUPS_DATADIR=/usr/share/cups"
D [27/Aug/2003:07:27:28 -0400] StartJob: envp[14]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [27/Aug/2003:07:27:28 -0400] StartJob: statusfds = [ 6 7 ]
D [27/Aug/2003:07:27:28 -0400] StartJob: filterfds[1] = [ 9 -1 ]
D [27/Aug/2003:07:27:28 -0400] StartJob: filter = "/usr/lib/cups/filter/pstops"
D [27/Aug/2003:07:27:28 -0400] StartJob: filterfds[0] = [ 10 11 ]
D [27/Aug/2003:07:27:28 -0400] start_process("/usr/lib/cups/filter/pstops", 0xbfff0250, 0xbffef5c0, 9, 11, 7)
I [27/Aug/2003:07:27:28 -0400] Started filter /usr/lib/cups/filter/pstops (PID 691) for job 18.
D [27/Aug/2003:07:27:28 -0400] StartJob: filter = "/usr/lib/cups/filter/foomatic-rip"
D [27/Aug/2003:07:27:28 -0400] StartJob: filterfds[1] = [ 9 12 ]
D [27/Aug/2003:07:27:28 -0400] start_process("/usr/lib/cups/filter/foomatic-rip", 0xbfff0250, 0xbffef5c0, 10, 12, 7)
I [27/Aug/2003:07:27:28 -0400] Started filter /usr/lib/cups/filter/foomatic-rip (PID 692) for job 18.
D [27/Aug/2003:07:27:28 -0400] StartJob: backend = "/usr/lib/cups/backend/parallel"
D [27/Aug/2003:07:27:28 -0400] StartJob: filterfds[0] = [ -1 10 ]
D [27/Aug/2003:07:27:28 -0400] start_process("/usr/lib/cups/backend/parallel", 0xbfff0250, 0xbffef5c0, 9, 10, 7)
I [27/Aug/2003:07:27:28 -0400] Started backend /usr/lib/cups/backend/parallel (PID 693) for job 18.
D [27/Aug/2003:07:27:28 -0400] ProcessIPPRequest: 5 status_code=0
D [27/Aug/2003:07:27:28 -0400] [Job 18] Page = 612x792; 0,0 to 612,792
D [27/Aug/2003:07:27:28 -0400] [Job 18] slowcollate=0, slowduplex=0, sloworder=0
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%BoundingBox: 18 36 594 756
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%Title: Enscript Output
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%For: Joseph Barillari,,,
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%Creator: GNU enscript 1.6.3
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%CreationDate: Sun Jul 27 22:58:41 2003
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%Orientation: Portrait
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%Pages: (atend)
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%DocumentMedia: Letter 612 792 0 () ()
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%DocumentNeededResources: (atend)
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%EndComments
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%BeginProlog
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%BeginResource: procset Enscript-Prolog 1.6 3
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%EndResource
D [27/Aug/2003:07:27:28 -0400] [Job 18] 0 %%BeginResource: procset Enscript-Encoding-88591 1.6 3
D [27/Aug/2003:07:27:28 -0400] [Job 18] perl: warning: Setting locale failed.
D [27/Aug/2003:07:27:28 -0400] [Job 18] perl: warning: Please check that your locale settings:
D [27/Aug/2003:07:27:28 -0400] [Job 18] LANGUAGE = (unset),
D [27/Aug/2003:07:27:28 -0400] [Job 18] LC_ALL = (unset),
D [27/Aug/2003:07:27:28 -0400] [Job 18] LANG = "en"
D [27/Aug/2003:07:27:28 -0400] [Job 18] are supported and installed on your system.
D [27/Aug/2003:07:27:28 -0400] [Job 18] perl: warning: Falling back to the standard locale ("C").
D [27/Aug/2003:07:27:28 -0400] CloseClient() 5
D [27/Aug/2003:07:27:29 -0400] [Job 18] foomatic-rip version $Revision: 3.34 $ running...
D [27/Aug/2003:07:27:29 -0400] [Job 18] Parsing PPD file ...
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option ColorSpace
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option PageSize
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option PageRegion
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option ImageableArea
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option PaperDimension
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option Resolution
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option ColorMode
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option Bidirectional
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option AlignA
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option AlignB
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option AlignC
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option AlignD
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option NumPasses
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option Model
D [27/Aug/2003:07:27:29 -0400] [Job 18] Added option Font
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] Parameter Summary
D [27/Aug/2003:07:27:29 -0400] [Job 18] -----------------
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] Spooler: cups
D [27/Aug/2003:07:27:29 -0400] [Job 18] Printer: ij
D [27/Aug/2003:07:27:29 -0400] [Job 18] PPD file: /etc/cups/ppd/ij.ppd
D [27/Aug/2003:07:27:29 -0400] [Job 18] Printer model: Compaq IJ750, Foomatic + lxm3200-tweaked (recommended)
D [27/Aug/2003:07:27:29 -0400] [Job 18] Job title: test.ps
D [27/Aug/2003:07:27:29 -0400] [Job 18] File(s) to be printed:
D [27/Aug/2003:07:27:29 -0400] [Job 18] <STDIN>
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] ================================================
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] File: <STDIN>
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] ================================================
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] Reading PostScript input ...
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%EndResource
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%EndProlog
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%BeginSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%IncludeResource: font Courier-Bold
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%IncludeResource: font Courier
D [27/Aug/2003:07:27:29 -0400] [Job 18] --> This document is DSC-conforming!
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] -----------
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginProlog
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%BeginResource: procset Enscript-Header-simple 1.6 3
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%EndResource
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%EndSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%Page: (1) 1
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%Page: (1) 1
D [27/Aug/2003:07:27:29 -0400] [Job 18] pw = 612.0, pl = 792.0
D [27/Aug/2003:07:27:29 -0400] [Job 18] PageLeft = 0.0, PageRight = 612.0
D [27/Aug/2003:07:27:29 -0400] [Job 18] PageTop = 792.0, PageBottom = 0.0
D [27/Aug/2003:07:27:29 -0400] [Job 18] PageWidth = 612.0, PageLength = 792.0
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%BeginPageSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%EndPageSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] 0 %%Trailer
D [27/Aug/2003:07:27:29 -0400] [Job 18] Saw Trailer!
D [27/Aug/2003:07:27:29 -0400] [Job 18] Saw EOF!
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%EndProlog
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] -----------
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] Inserting PostScript code for CUPS' page accounting
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *PageSize Letter
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: PageSize=Letter --> Option will be set by PostScript interpreter
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *Resolution 600x600dpi
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: Resolution=600x600dpi --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: Resolution=600x600dpi
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: Resolution=600x600dpi --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *ColorMode Colour
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: ColorMode=Colour --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: ColorMode=Colour
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: ColorMode=Colour --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *Bidirectional off
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: Bidirectional=off --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: Bidirectional=off
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: Bidirectional=off --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *NumPasses 1
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: NumPasses=1 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: NumPasses=1
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: NumPasses=1 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *AlignA 16
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignA=16 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: AlignA=16
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignA=16 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *AlignB 8
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignB=8 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: AlignB=8
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignB=8 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *AlignC 16
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignC=16 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: AlignC=16
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignC=16 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginFeature: *AlignD 16
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignD=16 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %% FoomaticRIPOptionSetting: AlignD=16
D [27/Aug/2003:07:27:29 -0400] [Job 18] Option: AlignD=16 --> Setting option
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%EndSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] -----------
D [27/Aug/2003:07:27:29 -0400] [Job 18] New page:  1 1
D [27/Aug/2003:07:27:29 -0400] [Job 18] Inserting option code into "PageSetup" section.
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%BeginPageSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] Found: %%EndPageSetup
D [27/Aug/2003:07:27:29 -0400] [Job 18] End of page header
D [27/Aug/2003:07:27:29 -0400] [Job 18] Flushing FIFO.
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] Starting renderer
D [27/Aug/2003:07:27:29 -0400] [Job 18] renderer PID pid4=695
D [27/Aug/2003:07:27:29 -0400] [Job 18] JCL: <job data>
D [27/Aug/2003:07:27:29 -0400] [Job 18] 
D [27/Aug/2003:07:27:29 -0400] [Job 18] renderer command: gs -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=lex3200 -dmodel=0 -r600x600 -dmode=1 -dbidir=0 -dnumpass=1 -dAlgnA=16 -dAlgnB=8 -dAlgnC=16 -dAlgnD=16 -sOutputFile=- -
D [27/Aug/2003:07:27:29 -0400] [Job 18] perl: warning: Setting locale failed.
D [27/Aug/2003:07:27:29 -0400] [Job 18] perl: warning: Please check that your locale settings:
D [27/Aug/2003:07:27:29 -0400] [Job 18] LANGUAGE = (unset),
D [27/Aug/2003:07:27:29 -0400] [Job 18] LC_ALL = (unset),
D [27/Aug/2003:07:27:29 -0400] [Job 18] LANG = "en"
D [27/Aug/2003:07:27:29 -0400] [Job 18] are supported and installed on your system.
D [27/Aug/2003:07:27:29 -0400] [Job 18] perl: warning: Falling back to the standard locale ("C").
D [27/Aug/2003:07:27:29 -0400] [Job 18] foomatic-gswrapper: gs '-dBATCH' '-dPARANOIDSAFER' '-dQUIET' '-dNOPAUSE' '-sDEVICE=lex3200' '-dmodel=0' '-r600x600' '-dmode=1' '-dbidir=0' '-dnumpass=1' '-dAlgnA=16' '-dAlgnB=8' '-dAlgnC=16' '-dAlgnD=16' '-sOutputFile=| cat >&3' '/dev/fd/0' 3>&1 1>&2
D [27/Aug/2003:07:27:30 -0400] [Job 18] 
D [27/Aug/2003:07:27:30 -0400] [Job 18] Closing renderer


-- 
Joseph Barillari -- http://barillari.org



Reply to: