HP LaserJet P1006 / P1008 :  foo2zjs - foo2hp - foo2xqx - foo2lava - foo2qpdl - foo2oak
Support for linux printer drivers
The fastest message board... ever.
 
foo2xqx not working on FreeBSD 10.1 (TrueOS 10.1)
Posted by: billakay ()
Date: January 21, 2015 03:00PM

Hello,

I've been trying to get my HP LaserJet P1006 working on FreeBSD 10.1 (TrueOS 10.1) for two days now with no luck.

I installed cups and friends as FreeBSD packages (following the instructions in the INSTALL doc).

I am able to get the printer to be detected by the kernel, and I can manually load
the firmware, convert a PS to XQX, and cat it to the printer to get a printout.

CUPS, however is crapping with an error "Filter failed".

I will post my error log next. It seems to me that something is not producing PS properly, and this is causing foomatic-rip to die.

Any ideas?

Thanks in advance,
Bill

Options: ReplyQuote
Re: foo2xqx not working on FreeBSD 10.1 (TrueOS 10.1)
Posted by: billakay ()
Date: January 21, 2015 03:00PM

Error log:

E [21/Jan/2015:19:18:37 +0000] [Job 23] Job stopped due to filter errors; please consult the error_log file for details.
D [21/Jan/2015:19:18:37 +0000] [Job 23] The following messages were recorded from 19:18:18 to 19:18:37
D [21/Jan/2015:19:18:37 +0000] [Job 23] Adding start banner page "none".
D [21/Jan/2015:19:18:37 +0000] [Job 23] Adding end banner page "none".
D [21/Jan/2015:19:18:37 +0000] [Job 23] File of type application/vnd.cups-pdf-banner queued by "anonymous".
D [21/Jan/2015:19:18:37 +0000] [Job 23] hold_until=0
D [21/Jan/2015:19:18:37 +0000] [Job 23] Queued on "HP_LaserJet_P1006" by "anonymous".
D [21/Jan/2015:19:18:37 +0000] [Job 23] time-at-processing=1421867898
D [21/Jan/2015:19:18:37 +0000] [Job 23] 4 filters for job:
D [21/Jan/2015:19:18:37 +0000] [Job 23] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 32)
D [21/Jan/2015:19:18:37 +0000] [Job 23] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [21/Jan/2015:19:18:37 +0000] [Job 23] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [21/Jan/2015:19:18:37 +0000] [Job 23] foomatic-rip (application/vnd.cups-postscript to printer/HP_LaserJet_P1006, cost 0)
D [21/Jan/2015:19:18:37 +0000] [Job 23] job-sheets=none,none
D [21/Jan/2015:19:18:37 +0000] [Job 23] argv[0]="HP_LaserJet_P1006"
D [21/Jan/2015:19:18:37 +0000] [Job 23] argv[1]="23"
D [21/Jan/2015:19:18:37 +0000] [Job 23] argv[2]="anonymous"
D [21/Jan/2015:19:18:37 +0000] [Job 23] argv[3]="Test Page"
D [21/Jan/2015:19:18:37 +0000] [Job 23] argv[4]="1"
D [21/Jan/2015:19:18:37 +0000] [Job 23] argv[5]="job-uuid=urn:uuid:d78d81b8-2df2-33e7-672c-fc6dfadc2c5b job-originating-host-name=localhost time-at-creation=1421867898 time-at-processing=1421867898"
D [21/Jan/2015:19:18:37 +0000] [Job 23] argv[6]="/var/spool/cups/d00023-001"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[0]="CUPS_CACHEDIR=/var/db/cups"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[1]="CUPS_DATADIR=/usr/local/share/cups"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[2]="CUPS_DOCROOT=/usr/local/share/doc/cups"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[3]="CUPS_FONTPATH=/usr/local/share/cups/fonts"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[5]="CUPS_SERVERBIN=/usr/local/libexec/cups"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[6]="CUPS_SERVERROOT=/usr/local/etc/cups"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[8]="HOME=/var/spool/cups/tmp"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[9]="PATH=/usr/local/libexec/cups/filter:/usr/local/bin:/usr/local/sbin:/bin:/usr/bin"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[10]="SERVER_ADMIN=root@localhost"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[11]="SOFTWARE=CUPS/1.7.3"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[13]="USER=root"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[14]="CUPS_MAX_MESSAGE=2047"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[15]="CUPS_SERVER=/var/run/cups.sock"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[17]="IPP_PORT=631"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[18]="CHARSET=utf-8"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[19]="LANG=en_US.UTF-8"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[20]="PPD=/usr/local/etc/cups/ppd/HP_LaserJet_P1006.ppd"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[21]="RIP_MAX_CACHE=128m"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[23]="DEVICE_URI=usb:/dev/ulpt0"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[24]="PRINTER_INFO=HP_LaserJet_P1006"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[25]="PRINTER_LOCATION="
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[26]="PRINTER=HP_LaserJet_P1006"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[27]="PRINTER_STATE_REASONS=none"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[28]="CUPS_FILETYPE=document"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [21/Jan/2015:19:18:37 +0000] [Job 23] envp[30]="AUTH_I****"
D [21/Jan/2015:19:18:37 +0000] [Job 23] Started filter /usr/local/libexec/cups/filter/bannertopdf (PID 30391)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Started filter /usr/local/libexec/cups/filter/pdftopdf (PID 30392)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Started filter /usr/local/libexec/cups/filter/pdftops (PID 30393)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Started filter /usr/local/libexec/cups/filter/foomatic-rip (PID 30394)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Started backend /usr/local/libexec/cups/backend/usb (PID 30396)
D [21/Jan/2015:19:18:37 +0000] [Job 23] pdftops - copying to temp print file "/var/spool/cups/tmp/076b954c71020"
D [21/Jan/2015:19:18:37 +0000] [Job 23] STATE: +connecting-to-device
D [21/Jan/2015:19:18:37 +0000] [Job 23] STATE: -connecting-to-device
D [21/Jan/2015:19:18:37 +0000] [Job 23] backendRunLoop(print_fd=0, device_fd=5, snmp_fd=-1, addr=0x0, use_bc=0, side_cb=0x4022b0)
D [21/Jan/2015:19:18:37 +0000] [Job 23] PDF template file doesn't have form. It's okay.
D [21/Jan/2015:19:18:37 +0000] [Job 23] PID 30391 (/usr/local/libexec/cups/filter/bannertopdf) exited with no errors.
D [21/Jan/2015:19:18:37 +0000] [Job 23] PID 30392 (/usr/local/libexec/cups/filter/pdftopdf) exited with no errors.
D [21/Jan/2015:19:18:37 +0000] [Job 23] Printer make and model: HP HP LaserJet P1006
D [21/Jan/2015:19:18:37 +0000] [Job 23] Running command line for pstops: pstops 23 anonymous 'Test Page' 1 'job-uuid=urn:uuid:d78d81b8-2df2-33e7-672c-fc6dfadc2c5b job-originating-host-name=localhost time-at-creation=1421867898 time-at-processing=1421867898'
D [21/Jan/2015:19:18:37 +0000] [Job 23] Using image rendering resolution 600 dpi
D [21/Jan/2015:19:18:37 +0000] [Job 23] Running command line for gs: gs -q -dNOPAUSE -dBATCH -dSAFER -sDEVICE=ps2write -sOUTPUTFILE=%stdout -dLanguageLevel=3 -r600 -dCompressFonts=false -dNoT3CCITT -dNOINTERPOLATE -c 'save pop' -f /var/spool/cups/tmp/076b954c71020
D [21/Jan/2015:19:18:37 +0000] [Job 23] Started filter gs (PID 30399)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Started filter pstops (PID 30400)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Page = 612x792; 11,11 to 601,781
D [21/Jan/2015:19:18:37 +0000] [Job 23] slow_collate=0, slow_duplex=0, slow_order=0
D [21/Jan/2015:19:18:37 +0000] [Job 23] Before copy_comments - %!PS-Adobe-3.0
D [21/Jan/2015:19:18:37 +0000] [Job 23] %!PS-Adobe-3.0
D [21/Jan/2015:19:18:37 +0000] [Job 23] %%BoundingBox: 0 0 612 792
D [21/Jan/2015:19:18:37 +0000] [Job 23] %%Creator: GPL Ghostscript 906 (ps2write)
D [21/Jan/2015:19:18:37 +0000] [Job 23] %%LanguageLevel: 2
D [21/Jan/2015:19:18:37 +0000] [Job 23] %%CreationDate: D:20150121191818Z00'00'
D [21/Jan/2015:19:18:37 +0000] [Job 23] %%Pages: 1
D [21/Jan/2015:19:18:37 +0000] [Job 23] %%EndComments
D [21/Jan/2015:19:18:37 +0000] [Job 23] Before copy_prolog - %%BeginProlog
D [21/Jan/2015:19:18:37 +0000] [Job 23] Before copy_setup - %%Page: 1 1
D [21/Jan/2015:19:18:37 +0000] [Job 23] Before page loop - %%Page: 1 1
D [21/Jan/2015:19:18:37 +0000] [Job 23] Copying page 1...
D [21/Jan/2015:19:18:37 +0000] [Job 23] pagew = 589.3, pagel = 769.3
D [21/Jan/2015:19:18:37 +0000] [Job 23] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [21/Jan/2015:19:18:37 +0000] [Job 23] PageLeft = 11.3, PageRight = 600.7
D [21/Jan/2015:19:18:37 +0000] [Job 23] PageTop = 780.7, PageBottom = 11.3
D [21/Jan/2015:19:18:37 +0000] [Job 23] PageWidth = 612.0, PageLength = 792.0
D [21/Jan/2015:19:18:37 +0000] [Job 23] Wrote 1 pages...
D [21/Jan/2015:19:18:37 +0000] [Job 23] PID 30400 (pstops) exited with no errors.
D [21/Jan/2015:19:18:37 +0000] [Job 23] PID 30399 (gs) exited with no errors.
D [21/Jan/2015:19:18:37 +0000] [Job 23] PID 30393 (/usr/local/libexec/cups/filter/pdftops) exited with no errors.
D [21/Jan/2015:19:18:37 +0000] [Job 23] Getting input from file /tmp/.foomatic-pdf.gwO6S3dg4
D [21/Jan/2015:19:18:37 +0000] [Job 23] foomatic-rip version 4.0.17.256 running...
D [21/Jan/2015:19:18:37 +0000] [Job 23] Parsing PPD file ...
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option ColorSpace
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option PageSize
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option Quality
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option Resolution
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option ImageableArea
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option PaperDimension
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option InputSlot
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option MediaType
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option Density
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option Duplex
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option Copies
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option halftone
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option NupOrient
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option NupPages
D [21/Jan/2015:19:18:37 +0000] [Job 23] Added option Font
D [21/Jan/2015:19:18:37 +0000] [Job 23] Parameter Summary
D [21/Jan/2015:19:18:37 +0000] [Job 23] -----------------
D [21/Jan/2015:19:18:37 +0000] [Job 23] Spooler: cups
D [21/Jan/2015:19:18:37 +0000] [Job 23] Printer: HP_LaserJet_P1006
D [21/Jan/2015:19:18:37 +0000] [Job 23] Shell: /bin/sh
D [21/Jan/2015:19:18:37 +0000] [Job 23] PPD file: /usr/local/etc/cups/ppd/HP_LaserJet_P1006.ppd
D [21/Jan/2015:19:18:37 +0000] [Job 23] ATTR file:
D [21/Jan/2015:19:18:37 +0000] [Job 23] Printer model: HP LaserJet P1006 Foomatic/foo2xqx (recommended)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Job title: Test Page
D [21/Jan/2015:19:18:37 +0000] [Job 23] File(s) to be printed:
D [21/Jan/2015:19:18:37 +0000] [Job 23] /tmp/.foomatic-pdf.gwO6S3dg4
D [21/Jan/2015:19:18:37 +0000] [Job 23] Ghostscript extra search path ('GS_LIB'): /usr/local/share/cups/fonts
D [21/Jan/2015:19:18:37 +0000] [Job 23] Printing system options:
D [21/Jan/2015:19:18:37 +0000] [Job 23] Pondering option 'job-uuid=urn:uuid:d78d81b8-2df2-33e7-672c-fc6dfadc2c5b'
D [21/Jan/2015:19:18:37 +0000] [Job 23] Unknown option job-uuid=urn:uuid:d78d81b8-2df2-33e7-672c-fc6dfadc2c5b.
D [21/Jan/2015:19:18:37 +0000] [Job 23] Pondering option 'job-originating-host-name=localhost'
D [21/Jan/2015:19:18:37 +0000] [Job 23] Unknown option job-originating-host-name=localhost.
D [21/Jan/2015:19:18:37 +0000] [Job 23] Pondering option 'time-at-creation=1421867898'
D [21/Jan/2015:19:18:37 +0000] [Job 23] Unknown option time-at-creation=1421867898.
D [21/Jan/2015:19:18:37 +0000] [Job 23] Pondering option 'time-at-processing=1421867898'
D [21/Jan/2015:19:18:37 +0000] [Job 23] Unknown option time-at-processing=1421867898.
D [21/Jan/2015:19:18:37 +0000] [Job 23] Options from the PPD file:
D [21/Jan/2015:19:18:37 +0000] [Job 23] ================================================
D [21/Jan/2015:19:18:37 +0000] [Job 23] File: /tmp/.foomatic-pdf.gwO6S3dg4
D [21/Jan/2015:19:18:37 +0000] [Job 23] ================================================
D [21/Jan/2015:19:18:37 +0000] [Job 23] Filetype: PostScript
D [21/Jan/2015:19:18:37 +0000] [Job 23] Reading PostScript input ...
D [21/Jan/2015:19:18:37 +0000] [Job 23] Job does not start with "%!", is it Postscript?
D [21/Jan/2015:19:18:37 +0000] [Job 23] Starting file converter
D [21/Jan/2015:19:18:37 +0000] [Job 23] Starting converter for non-PostScript files
D [21/Jan/2015:19:18:37 +0000] [Job 23] Starting process "kid1" (generation 1)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Starting process "kid2" (generation 2)
D [21/Jan/2015:19:18:37 +0000] [Job 23] Process is dying with "Couldn't dup fileconverter_handle
D [21/Jan/2015:19:18:37 +0000] [Job 23] ", exit stat 9
D [21/Jan/2015:19:18:37 +0000] [Job 23] Cleaning up...
D [21/Jan/2015:19:18:37 +0000] [Job 23] Killing kid1
D [21/Jan/2015:19:18:37 +0000] [Job 23] kid2: writing alreadyread
D [21/Jan/2015:19:18:37 +0000] [Job 23] Process is dying with "Caught termination signal: Job canceled
D [21/Jan/2015:19:18:37 +0000] [Job 23] ", exit stat 0
D [21/Jan/2015:19:18:37 +0000] [Job 23] Cleaning up...
D [21/Jan/2015:19:18:37 +0000] [Job 23] kid2: Then read the rest from standard input
D [21/Jan/2015:19:18:37 +0000] [Job 23] PID 30394 (/usr/local/libexec/cups/filter/foomatic-rip) stopped with status 9.
D [21/Jan/2015:19:18:37 +0000] [Job 23] Hint: Try setting the LogLevel to "debug" to find out more.
D [21/Jan/2015:19:18:37 +0000] [Job 23] PID 30396 (/usr/local/libexec/cups/backend/usb) exited with no errors.
D [21/Jan/2015:19:18:37 +0000] [Job 23] End of messages
D [21/Jan/2015:19:18:37 +0000] [Job 23] printer-state=3(idle)
D [21/Jan/2015:19:18:37 +0000] [Job 23] printer-state-message="Filter failed"
D [21/Jan/2015:19:18:37 +0000] [Job 23] printer-state-reasons=none
E [21/Jan/2015:19:23:39 +0000] [Job 23] Stopping unresponsive job.

Options: ReplyQuote
Re: foo2xqx not working on FreeBSD 10.1 (TrueOS 10.1)
Posted by: rickrich ()
Date: January 21, 2015 06:48PM

Set up Virtualbox PC-BSD 10.1. Browsed to localhost:631 and set the "Save debugging information for troubleshooting". Printed a Test Page. Then viewed the Error Log:

D [21/Jan/2015:17:09:33 -0600] [Job 2] Filetype: PostScript
D [21/Jan/2015:17:09:33 -0600] [Job 2] Reading PostScript input ...
D [21/Jan/2015:17:09:33 -0600] [Job 2] Job does not start with "%!", is it Postscript?
D [21/Jan/2015:17:09:33 -0600] [Job 2] Starting file converter
D [21/Jan/2015:17:09:33 -0600] [Job 2] Starting converter for non-PostScript files
D [21/Jan/2015:17:09:33 -0600] [Job 2] Starting process "kid1" (generation 1)
D [21/Jan/2015:17:09:33 -0600] [Job 2] Starting process "kid2" (generation 2)
D [21/Jan/2015:17:09:33 -0600] [Job 2] Process is dying with "kid2: writing alreadyread
D [21/Jan/2015:17:09:33 -0600] [Job 2] Starting process "fileconverter" (generation 2)
D [21/Jan/2015:17:09:33 -0600] [Job 2] kid2: Then read the rest from standard input
D [21/Jan/2015:17:09:33 -0600] [Job 2] Couldn't dup fileconverter_handle
D [21/Jan/2015:17:09:33 -0600] [Job 2] Syntax error: Unterminated quoted string
D [21/Jan/2015:17:09:33 -0600] [Job 2] ", exit stat 9

No idea. Maybe its: Syntax error: Unterminated quoted string. Maybe its: "Job does not start with "%!", is it Postscript?"

Check with the PC-BSD or Cups people.

Options: ReplyQuote
Re: foo2xqx not working on FreeBSD 10.1 (TrueOS 10.1)
Posted by: billakay ()
Date: January 22, 2015 08:31AM

Thanks for looking. I don't think its foo2xqx. I captured the output from the stage right before foomatic-rip (ps file) and tried to run foomatic-rip manually on the command line and it blows up the same way. Either there is a bug in foomatic-rip or the previous stage is screwing something up. I even recompiled foomatic-rip bypassing the offending check and it blew up later, so something looks to be up with the format of that PS file.

Options: ReplyQuote
Re: foo2xqx not working on FreeBSD 10.1 (TrueOS 10.1)
Posted by: rickrich ()
Date: January 24, 2015 11:12AM

Maybe read this PCBSD bug report. "Job does not start with "%!", is it Postscript?"

http://trac.pcbsd.org/attachment/ticket/1448/foomatic-rip-NINTGK.log
http://trac.pcbsd.org/ticket/1448

Options: ReplyQuote
Re: foo2xqx not working on FreeBSD 10.1 (TrueOS 10.1)
Posted by: rickrich ()
Date: January 24, 2015 11:40AM

https://github.com/pcbsd/freebsd-ports/commit/df7c7a686fb2551adefed44d9eb35ddf52a93922


-rwxr-xr-x 1 root wheel 302872 Nov 6 20:47 /usr/local/bin/foomatic-rip
-r-xr-xr-x 1 root wheel 487 Nov 6 20:47 /usr/local/libexec/cups/filter/foomatic-rip
lrwxr-xr-x 1 root wheel 27 Nov 6 20:47 /usr/local/libexec/cups/filter/foomatic-rip.exec -> /usr/local/bin/foomatic-rip

I think /usr/local/bin/foomatic-rip should be replaced with the wrapper script, too:

mv /usr/local/bin/foomatic-rip /usr/local/bin/foomatic-rip.exec
cp /usr/local/libexec/cups/filter/foomatic-rip /usr/local/bin/foomatic-rip
rm /usr/local/libexec/cups/filter/foomatic-rip.exec
ln -s /usr/local/bin/foomatic-rip.exec usr/local/libexec/cups/filter/foomatic-rip.exec

Options: ReplyQuote


Sorry, only registered users may post in this forum.
This forum powered by Phorum.