[Pkg-cups-devel] Bug#631282: [cups] Cups filter cpdftocps fails, causing failure to print pdf files

Wed Jun 22 14:39:40 UTC 2011

Package: cups
Version: 1.4.6-9
Severity: normal

--- Please enter the report below this line. ---

I'm having this issue for a couple of weeks. After a cups update, my 
cups system began failing PDF files. Even after a fresh reinstall the 
issue remained.

When I examined error log I noticed:

E [22/Jun/2011:17:18:06 +0300] [Job 10] Job stopped due to filter 
errors; please consult the error_log file for details.
...
D [22/Jun/2011:17:18:06 +0300] [Job 10] eval: 1: 1200x600dpi: not found
D [22/Jun/2011:17:18:06 +0300] [Job 10] Cannot process "<STDIN>": 
Unknown filetype.
D [22/Jun/2011:17:18:06 +0300] [Job 10] Process is dying with "Could not 
print file <STDIN>
D [22/Jun/2011:17:18:06 +0300] [Job 10] ", exit stat 2
D [22/Jun/2011:17:18:06 +0300] [Job 10] Cleaning up...
D [22/Jun/2011:17:18:06 +0300] [Job 10] End of messages
D [22/Jun/2011:17:18:06 +0300] [Job 10] printer-state=3(idle)
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
printer-state-message="/usr/lib/cups/filter/cpdftocps failed"
D [22/Jun/2011:17:18:06 +0300] [Job 10] printer-state-reasons=non

My printer is HP Laserjet P1005 which is accessed over a smb backend and 
I use foo2xqx driver compiled and installed externally.

The problem surfaces only for PDF files (I can print other documents .ps 
or .doc, I can print test pages). Also when I try to print PDF files 
with another network printer (accessed over socket backend and use a 
standard driver bundled with cups) printing is successfull, since 
cpdftocps filter is not started.

The relevant section in /var/log/cups/error_log and sysem information 
are below.

Thanks.

E [22/Jun/2011:17:18:06 +0300] [Job 10] Job stopped due to filter 
errors; please consult the error_log file for details.
D [22/Jun/2011:17:18:06 +0300] [Job 10] The following messages were 
recorded from 17:18:06 to 17:18:06
D [22/Jun/2011:17:18:06 +0300] [Job 10] Adding start banner page "none".
D [22/Jun/2011:17:18:06 +0300] [Job 10] Adding end banner page "none".
D [22/Jun/2011:17:18:06 +0300] [Job 10] File of type application/pdf 
queued by "utku".
D [22/Jun/2011:17:18:06 +0300] [Job 10] hold_until=0
D [22/Jun/2011:17:18:06 +0300] [Job 10] Queued on "a206print" by "utku".
D [22/Jun/2011:17:18:06 +0300] [Job 10] job-sheets=none,none
D [22/Jun/2011:17:18:06 +0300] [Job 10] argv[0]="a206print"
D [22/Jun/2011:17:18:06 +0300] [Job 10] argv[1]="10"
D [22/Jun/2011:17:18:06 +0300] [Job 10] argv[2]="utku"
D [22/Jun/2011:17:18:06 +0300] [Job 10] argv[3]="cups-test.pdf"
D [22/Jun/2011:17:18:06 +0300] [Job 10] argv[4]="1"
D [22/Jun/2011:17:18:06 +0300] [Job 10] argv[5]="NupOrient=port 
halftone=default number-up=1 PageSize=A4 Duplex=None 
Resolution=600x600dpi InputSlot=Auto NupPages=1up Quality=normal 
MediaType=Plain Density=Density3 
job-uuid=urn:uuid:df66dca9-76de-3519-4612-6864dac8ca82 
job-originating-host-name=localhost time-at-creation=1308752286 
time-at-processing=1308752286"
D [22/Jun/2011:17:18:06 +0300] [Job 10] argv[6]="/var/spool/cups/d00010-001"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[1]="CUPS_DATADIR=/usr/share/cups"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[7]="CUPS_STATEDIR=/var/run/cups"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[8]="HOME=/var/spool/cups/tmp"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[10]="SERVER_ADMIN=root at uther"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[11]="SOFTWARE=CUPS/1.4.6"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[12]="TMPDIR=/var/spool/cups/tmp"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[13]="TZ=Europe/Istanbul"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[14]="USER=root"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[16]="CUPS_ENCRYPTION=IfRequested"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[17]="IPP_PORT=631"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[18]="CHARSET=utf-8"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[19]="LANG=tr_TR.UTF-8"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[20]="PPD=/etc/cups/ppd/a206print.ppd"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[21]="RIP_MAX_CACHE=auto"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[22]="CONTENT_TYPE=application/pdf"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[23]="DEVICE_URI=smb://144.122.71.123/HP%20LaserJet%20P1005"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[24]="PRINTER_INFO=HP 
LaserJet P1005"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[25]="PRINTER_LOCATION=A 206"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[26]="PRINTER=a206print"
D [22/Jun/2011:17:18:06 +0300] [Job 10] envp[27]="CUPS_FILETYPE=document"
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
envp[28]="FINAL_CONTENT_TYPE=printer/a206print"
D [22/Jun/2011:17:18:06 +0300] [Job 10] Started filter 
/usr/lib/cups/filter/pdftopdf (PID 5828)
D [22/Jun/2011:17:18:06 +0300] [Job 10] Started filter 
/usr/lib/cups/filter/cpdftocps (PID 5829)
D [22/Jun/2011:17:18:06 +0300] [Job 10] Started filter 
/usr/lib/cups/filter/foomatic-rip (PID 5830)
D [22/Jun/2011:17:18:06 +0300] [Job 10] Started backend 
/usr/lib/cups/backend/smb (PID 5831)
D [22/Jun/2011:17:18:06 +0300] [Job 10] Getting input from file
D [22/Jun/2011:17:18:06 +0300] [Job 10] foomatic-rip version 4.0.7.235 
running...
D [22/Jun/2011:17:18:06 +0300] [Job 10] Parsing PPD file ...
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option PageSize
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option Quality
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option Resolution
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option ImageableArea
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option PaperDimension
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option InputSlot
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option MediaType
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option Density
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option Duplex
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option Copies
D [22/Jun/2011:17:18:06 +0300] [Job 10] Connected using Kerberos...
D [22/Jun/2011:17:18:06 +0300] [Job 10] pdftops argv[5] = 10 utku 
cups-test.pdf 1 NupOrient=port halftone=default number-up=1 PageSize=A4 
Duplex=None Resolution=600x600dpi InputSlot=Auto NupPages=1up 
Quality=normal MediaType=Plain Density=Density3 
job-uuid=urn:uuid:df66dca9-76de-3519-4612-6864dac8ca82 
job-originating-host-name=localhost time-at-creation=1308752286 
time-at-processing=1308752286
D [22/Jun/2011:17:18:06 +0300] [Job 10] PPD: /etc/cups/ppd/a206print.ppd
D [22/Jun/2011:17:18:06 +0300] [Job 10] /usr/bin/pdftops supports 
'-origpagesizes': yes
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option halftone
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option NupOrient
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option NupPages
D [22/Jun/2011:17:18:06 +0300] [Job 10] PostScript Level: 3
D [22/Jun/2011:17:18:06 +0300] [Job 10] Added option Font
D [22/Jun/2011:17:18:06 +0300] [Job 10]
D [22/Jun/2011:17:18:06 +0300] [Job 10] Parameter Summary
D [22/Jun/2011:17:18:06 +0300] [Job 10] -----------------
D [22/Jun/2011:17:18:06 +0300] [Job 10]
D [22/Jun/2011:17:18:06 +0300] [Job 10] Spooler: cups
D [22/Jun/2011:17:18:06 +0300] [Job 10] Printer: a206print
D [22/Jun/2011:17:18:06 +0300] [Job 10] Shell: /bin/bash
D [22/Jun/2011:17:18:06 +0300] [Job 10] PPD file: 
/etc/cups/ppd/a206print.ppd
D [22/Jun/2011:17:18:06 +0300] [Job 10] ATTR file:
D [22/Jun/2011:17:18:06 +0300] [Job 10] Printer model: HP LaserJet P1005 
Foomatic/foo2xqx (recommended)
D [22/Jun/2011:17:18:06 +0300] [Job 10] Job title: cups-test.pdf
D [22/Jun/2011:17:18:06 +0300] [Job 10] File(s) to be printed:
D [22/Jun/2011:17:18:06 +0300] [Job 10] <STDIN>
D [22/Jun/2011:17:18:06 +0300] [Job 10]
D [22/Jun/2011:17:18:06 +0300] [Job 10] Ghostscript extra search path 
('GS_LIB'): /usr/share/cups/fonts
D [22/Jun/2011:17:18:06 +0300] [Job 10] Printing system options:
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'number-up=1'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Unknown option number-up=1.
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 
'job-uuid=urn:uuid:df66dca9-76de-3519-4612-6864dac8ca82'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Unknown option 
job-uuid=urn:uuid:df66dca9-76de-3519-4612-6864dac8ca82.
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 
'job-originating-host-name=localhost'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Unknown option 
job-originating-host-name=localhost.
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 
'time-at-creation=1308752286'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Unknown option 
time-at-creation=1308752286.
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 
'time-at-processing=1308752286'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Unknown option 
time-at-processing=1308752286.
D [22/Jun/2011:17:18:06 +0300] [Job 10] Options from the PPD file:
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'NupOrient=port'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'halftone=default'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'PageSize=A4'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'Duplex=None'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 
'Resolution=600x600dpi'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'InputSlot=Auto'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'NupPages=1up'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'Quality=normal'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'MediaType=Plain'
D [22/Jun/2011:17:18:06 +0300] [Job 10] Pondering option 'Density=Density3'
D [22/Jun/2011:17:18:06 +0300] [Job 10]
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
================================================
D [22/Jun/2011:17:18:06 +0300] [Job 10]
D [22/Jun/2011:17:18:06 +0300] [Job 10] File: <STDIN>
D [22/Jun/2011:17:18:06 +0300] [Job 10]
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
================================================
D [22/Jun/2011:17:18:06 +0300] [Job 10]
D [22/Jun/2011:17:18:06 +0300] [Job 10] Duplex: no
D [22/Jun/2011:17:18:06 +0300] [Job 10] eval: 1: 1200x600dpi: not found
D [22/Jun/2011:17:18:06 +0300] [Job 10] Cannot process "<STDIN>": 
Unknown filetype.
D [22/Jun/2011:17:18:06 +0300] [Job 10] Process is dying with "Could not 
print file <STDIN>
D [22/Jun/2011:17:18:06 +0300] [Job 10] ", exit stat 2
D [22/Jun/2011:17:18:06 +0300] [Job 10] Cleaning up...
D [22/Jun/2011:17:18:06 +0300] [Job 10] End of messages
D [22/Jun/2011:17:18:06 +0300] [Job 10] printer-state=3(idle)
D [22/Jun/2011:17:18:06 +0300] [Job 10] 
printer-state-message="/usr/lib/cups/filter/cpdftocps failed"
D [22/Jun/2011:17:18:06 +0300] [Job 10] printer-state-reasons=none

--- System information. ---
Architecture: amd64
Kernel: Linux 2.6.39-2-amd64

Debian Release: wheezy/sid
500 unstable ftp.linux.org.tr
500 unstable ftp.debian.org
500 stable dl.google.com

--- Package information. ---
Depends (Version) | Installed
====================================-+-================
libacl1 (>= 2.2.11-1) | 2.2.49-5
libavahi-client3 (>= 0.6.16) | 0.6.30-3
libavahi-common3 (>= 0.6.16) | 0.6.30-3
libc6 (>= 2.7) | 2.13-7
libcups2 (>= 1.4.4-3~) | 1.4.6-9
libcupscgi1 (>= 1.4.2) | 1.4.6-9
libcupsdriver1 (>= 1.4.0) | 1.4.6-9
libcupsimage2 (>= 1.4.0) | 1.4.6-9
libcupsmime1 (>= 1.4.0) | 1.4.6-9
libcupsppdc1 (>= 1.4.0) | 1.4.6-9
libdbus-1-3 (>= 1.0.2) | 1.4.12-2
libgcc1 (>= 1:4.1.1) | 1:4.6.0-14
libgnutls26 (>= 2.9.11-0) | 2.10.5-1+b1
libgssapi-krb5-2 (>= 1.8+dfsg) | 1.9.1+dfsg-1+b1
libijs-0.35 | 0.35-7
libkrb5-3 (>= 1.6.dfsg.2) | 1.9.1+dfsg-1+b1
liblcms1 (>= 1.15-1) | 1.18.dfsg-1.2+b4
libldap-2.4-2 (>= 2.4.7) | 2.4.25-1.1
libpam0g (>= 0.99.7.1) | 1.1.3-1
libpaper1 | 1.1.24+nmu1
libpoppler5 | 0.12.4-1.2
libslp1 | 1.2.1-7.8
libstdc++6 (>= 4.1.1) | 4.6.0-14
libusb-0.1-4 (>= 2:0.1.12) | 2:0.1.12-17
zlib1g (>= 1:1.1.4) | 1:1.2.3.4.dfsg-3
debconf (>= 1.2.9) | 1.5.39
OR debconf-2.0 |
poppler-utils (>= 0.12) | 0.12.4-1.2
procps | 1:3.2.8-10
ghostscript | 9.02~dfsg-2
lsb-base (>= 3) | 3.2-27
cups-common (>= 1.4.6) | 1.4.6-9
cups-client (>= 1.4.6-9) | 1.4.6-9
ssl-cert (>= 1.0.11) | 1.0.28
adduser | 3.113
bc | 1.06.95-2
ttf-freefont | 20100919-1
cups-ppdc | 1.4.6-9

Recommends (Version) | Installed
=====================================-+-===========
avahi-daemon | 0.6.30-3
foomatic-filters (>= 4.0) | 4.0.7-1
cups-driver-gutenprint | 5.2.6-1
ghostscript-cups | 9.02~dfsg-2

Suggests (Version) | Installed
==========================================-+-===========
cups-bsd |
foomatic-db-compressed-ppds | 20110617-1
OR foomatic-db |
hplip |
cups-pdf |
udev | 171-1
smbclient | 2:3.5.9~dfsg-1

-- 
Utku Erdoğdu
Orta Doğu Teknik Universitesi
Bilgisayar Mühendisliği Bölümü