Bug#586324: Printing fails with "/usr/lib/cups/backend/socket failed"
Package: cups
Version: 1.4.3-1
Severity: important
*** Please type your report below this line ***
All over sudden, printing ceased to work, probably after some recent
upgrade. The final printer's state message, according to
/var/cups/error_log, is "/usr/lib/cups/backend/socket failed", and some
lines before the socket backend complains about
"/usr/lib/cups/backend/socket: Permission denied". I tried manually
granting various combinations of additional permissions to the socket,
but I either got the same error or found cups to refuse printing due to
insecure permissions.
Here's a sample excerpt from the error log, documenting a failed
printing attempt:
--------8<--------
E [18/Jun/2010:13:44:06 +0200] [Job 527] Job aborted due to backend
errors; please consult the error_log file for details.
D [18/Jun/2010:13:44:06 +0200] [Job 527] The following messages were
recorded from 01:43:57 PM to 01:44:06 PM
D [18/Jun/2010:13:44:06 +0200] [Job 527] Adding start banner page "none".
D [18/Jun/2010:13:44:06 +0200] [Job 527] Queued on
"color_laserjet_2550n" by "tcrass".
D [18/Jun/2010:13:44:06 +0200] [Job 527] Auto-typing file...
D [18/Jun/2010:13:44:06 +0200] [Job 527] Request file type is
application/postscript.
D [18/Jun/2010:13:44:06 +0200] [Job 527] File of type
application/postscript queued by "tcrass".
D [18/Jun/2010:13:44:06 +0200] [Job 527] Adding end banner page "none".
D [18/Jun/2010:13:44:06 +0200] [Job 527] job-sheets=none,none
D [18/Jun/2010:13:44:06 +0200] [Job 527] argv[0]="color_laserjet_2550n"
D [18/Jun/2010:13:44:06 +0200] [Job 527] argv[1]="527"
D [18/Jun/2010:13:44:06 +0200] [Job 527] argv[2]="tcrass"
D [18/Jun/2010:13:44:06 +0200] [Job 527] argv[3]="<*** Pssst - secret
pdf filename! ***>"
D [18/Jun/2010:13:44:06 +0200] [Job 527] argv[4]="1"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
argv[5]="orientation-requested=3
job-uuid=urn:uuid:f44c746d-a1a2-3ca8-5eaf-5e5675d16e38 nofitplot
media=A4 job-originating-host-name=localhost"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
argv[6]="/var/spool/cups/d00527-001"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[1]="CUPS_DATADIR=/usr/share/cups"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[7]="CUPS_STATEDIR=/var/run/cups"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[8]="HOME=/var/spool/cups/tmp"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[10]="SERVER_ADMIN=root@caladan"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[11]="SOFTWARE=CUPS/1.4.3"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[12]="TMPDIR=/var/spool/cups/tmp"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[13]="TZ=Europe/Berlin"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[14]="USER=root"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[16]="CUPS_ENCRYPTION=IfRequested"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[17]="IPP_PORT=631"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[18]="CHARSET=utf-8"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[19]="LANG=en_US.UTF-8"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[20]="PPD=/etc/cups/ppd/color_laserjet_2550n.ppd"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[21]="RIP_MAX_CACHE=258467k"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[22]="CONTENT_TYPE=application/postscript"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[23]="DEVICE_URI=socket://192.168.0.4:9100"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[24]="PRINTER_INFO=Farblaser"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[25]="PRINTER_LOCATION=Arbeitszimmer"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[26]="PRINTER=color_laserjet_2550n"
D [18/Jun/2010:13:44:06 +0200] [Job 527] envp[27]="CUPS_FILETYPE=document"
D [18/Jun/2010:13:44:06 +0200] [Job 527]
envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [18/Jun/2010:13:44:06 +0200] [Job 527] Started filter
/usr/lib/cups/filter/pstopdf (PID 8273)
D [18/Jun/2010:13:44:06 +0200] [Job 527] Started filter
/usr/lib/cups/filter/pdftopdf (PID 8274)
D [18/Jun/2010:13:44:06 +0200] [Job 527] Started filter
/usr/lib/cups/filter/cpdftocps (PID 8275)
D [18/Jun/2010:13:44:06 +0200] [Job 527] Started backend
/usr/lib/cups/backend/socket (PID 8277)
D [18/Jun/2010:13:44:06 +0200] [Job 527] pstopdf 6 args: 527 tcrass
Brief <*** Pssst - secret pdf filename! ***> 1 orientation-requested=3
job-uuid=urn:uuid:f44c746d-a1a2-3ca8-5eaf-5e5675d16e38 nofitplot
media=A4 job-originating-host-name=localhost /var/spool/cups/d00527-001
D [18/Jun/2010:13:44:06 +0200] [Job 527] PPD:
/etc/cups/ppd/color_laserjet_2550n.ppd
D [18/Jun/2010:13:44:06 +0200] [Job 527] /usr/lib/cups/backend/socket:
Permission denied
D [18/Jun/2010:13:44:06 +0200] [Job 527] Resolution: 600
D [18/Jun/2010:13:44:06 +0200] [Job 527] Page size: A4
D [18/Jun/2010:13:44:06 +0200] [Job 527] Width: 595, height: 842,
absolute margins: 12.00, 12.12, 583.08, 829.68
D [18/Jun/2010:13:44:06 +0200] [Job 527] Relative margins: 12.00, 12.12,
11.92, 12.32
D [18/Jun/2010:13:44:06 +0200] [Job 527] PPD options: -r600
-dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842
D [18/Jun/2010:13:44:06 +0200] [Job 527] PostScript to be injected:
D [18/Jun/2010:13:44:06 +0200] [Job 527] Running cat | /usr/bin/ps2pdf13
-dAutoRotatePages=/None -dAutoFilterColorImages=false
-dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr
-dColorImageFilter=/FlateEncode -dPDFSETTINGS=/printer
-dUseCIEColor -dDoNumCopies -r600 -dDEVICEWIDTHPOINTS=595
-dDEVICEHEIGHTPOINTS=842 - -
D [18/Jun/2010:13:44:06 +0200] [Job 527] pdftops argv[5] = 527 tcrass
<*** Pssst - secret pdf filename! ***> 1 orientation-requested=3
job-uuid=urn:uuid:f44c746d-a1a2-3ca8-5eaf-5e5675d16e38 nofitplot
media=A4 job-originating-host-name=localhost
D [18/Jun/2010:13:44:06 +0200] [Job 527] PPD:
/etc/cups/ppd/color_laserjet_2550n.ppd
D [18/Jun/2010:13:44:06 +0200] [Job 527] /usr/bin/pdftops supports
'-origpagesizes': yes
D [18/Jun/2010:13:44:06 +0200] [Job 527] PostScript Level: 2
D [18/Jun/2010:13:44:06 +0200] [Job 527] Duplex: no
D [18/Jun/2010:13:44:06 +0200] [Job 527] Resolution: 600
D [18/Jun/2010:13:44:06 +0200] [Job 527] Page size: A4
D [18/Jun/2010:13:44:06 +0200] [Job 527] Width: 595, height: 842,
absolute margins: 12.00, 12.12, 583.08, 829.68
D [18/Jun/2010:13:44:06 +0200] [Job 527] Relative margins: 12.00, 12.12,
11.92, 12.32
D [18/Jun/2010:13:44:06 +0200] [Job 527] PPD options: -level2 -origpagesizes
D [18/Jun/2010:13:44:06 +0200] [Job 527] PostScript to be injected:
D [18/Jun/2010:13:44:06 +0200] [Job 527] Device copies: 1; device collate:
D [18/Jun/2010:13:44:06 +0200] [Job 527] Running /usr/bin/pdftops
-level2 -origpagesizes /var/spool/cups/tmp/pdftops.BQOYCS -
D [18/Jun/2010:13:44:06 +0200] [Job 527] Running pstops '527' 'tcrass'
'<*** Pssst - secret pdf filename! ***>' '1' '
job-uuid=urn:uuid:f44c746d-a1a2-3ca8-5eaf-5e5675d16e38 media=A4
job-originating-host-name=localhost'
D [18/Jun/2010:13:44:06 +0200] [Job 527] Page = 595x842; 12,12 to 583,830
D [18/Jun/2010:13:44:06 +0200] [Job 527] slow_collate=0, slow_duplex=0,
slow_order=0
D [18/Jun/2010:13:44:06 +0200] [Job 527] Before copy_comments -
%!PS-Adobe-3.0
D [18/Jun/2010:13:44:06 +0200] [Job 527] %!PS-Adobe-3.0
D [18/Jun/2010:13:44:06 +0200] [Job 527] %%LanguageLevel: 2
D [18/Jun/2010:13:44:06 +0200] [Job 527] %%DocumentSuppliedResources:
(atend)
D [18/Jun/2010:13:44:06 +0200] [Job 527] %%DocumentMedia: plain 595 842
0 () ()
D [18/Jun/2010:13:44:06 +0200] [Job 527] %%BoundingBox: 0 0 595 842
D [18/Jun/2010:13:44:06 +0200] [Job 527] %%Pages: 1
D [18/Jun/2010:13:44:06 +0200] [Job 527] %%EndComments
D [18/Jun/2010:13:44:06 +0200] [Job 527] Before copy_prolog -
%%BeginDefaults
D [18/Jun/2010:13:44:06 +0200] [Job 527] Backend returned status 22
(unknown)
D [18/Jun/2010:13:44:06 +0200] [Job 527] End of messages
D [18/Jun/2010:13:44:06 +0200] [Job 527] printer-state=3(idle)
D [18/Jun/2010:13:44:06 +0200] [Job 527]
printer-state-message="/usr/lib/cups/backend/socket failed"
D [18/Jun/2010:13:44:06 +0200] [Job 527] printer-state-reasons=none
--------8<--------
-- System Information:
Debian Release: squeeze/sid
APT prefers unstable
APT policy: (990, 'unstable'), (500, 'testing'), (500, 'stable'), (1,
'experimental')
Architecture: i386 (i686)
Kernel: Linux 2.6.32-5-686 (SMP w/1 CPU core)
Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/bash
Versions of packages cups depends on:
ii adduser 3.112 add and remove users and groups
ii bc 1.06.95-2 The GNU bc arbitrary
precision cal
ii cups-client 1.4.3-1 Common UNIX Printing
System(tm) -
ii cups-common 1.4.3-1 Common UNIX Printing
System(tm) -
ii debconf [debconf-2.0] 1.5.32 Debian configuration
management sy
ii ghostscript 8.71~dfsg2-3 The GPL Ghostscript
PostScript/PDF
ii libavahi-client3 0.6.25-3 Avahi client library
ii libavahi-common3 0.6.25-3 Avahi common library
ii libc6 2.11.2-1 Embedded GNU C Library:
Shared lib
ii libcups2 1.4.3-1 Common UNIX Printing
System(tm) -
ii libcupscgi1 1.4.3-1 Common UNIX Printing
System(tm) -
ii libcupsdriver1 1.4.3-1 Common UNIX Printing
System(tm) -
ii libcupsimage2 1.4.3-1 Common UNIX Printing
System(tm) -
ii libcupsmime1 1.4.3-1 Common UNIX Printing
System(tm) -
ii libcupsppdc1 1.4.3-1 Common UNIX Printing
System(tm) -
ii libdbus-1-3 1.2.24-1 simple interprocess
messaging syst
ii libgcc1 1:4.4.4-5 GCC support library
ii libgnutls26 2.8.6-1 the GNU TLS library -
runtime libr
ii libgssapi-krb5-2 1.8.1+dfsg-5 MIT Kerberos runtime
libraries - k
ii libijs-0.35 0.35-7 IJS raster image transport
protoco
ii libkrb5-3 1.8.1+dfsg-5 MIT Kerberos runtime libraries
ii libldap-2.4-2 2.4.21-1 OpenLDAP libraries
ii libpam0g 1.1.1-3 Pluggable Authentication
Modules l
ii libpaper1 1.1.24 library for handling paper
charact
ii libpoppler5 0.12.4-1 PDF rendering library
ii libslp1 1.2.1-7.7 OpenSLP libraries
ii libstdc++6 4.4.4-5 The GNU Standard C++ Library v3
ii libusb-0.1-4 2:0.1.12-15 userspace USB programming
library
ii lsb-base 3.2-23.1 Linux Standard Base 3.2
init scrip
ii perl-modules 5.10.1-13 Core Perl modules
ii poppler-utils 0.12.4-1 PDF utilitites (based on
libpopple
ii procps 1:3.2.8-9 /proc file system utilities
ii ssl-cert 1.0.25 simple debconf wrapper for
OpenSSL
ii ttf-freefont 20090104-7 Freefont Serif, Sans and
Mono True
ii zlib1g 1:1.2.3.4.dfsg-3 compression library - runtime
Versions of packages cups recommends:
ii cups-driver-gutenprint 5.2.5-1 printer drivers for CUPS
ii foomatic-filters 4.0-20090509-1 OpenPrinting printer
support - fil
ii ghostscript-cups 8.71~dfsg2-3 The GPL Ghostscript
PostScript/PDF
Versions of packages cups suggests:
ii cups-bsd 1.4.3-1 Common UNIX Printing
System(tm) -
ii cups-pdf 2.5.0-15 PDF printer for CUPS
pn cups-ppdc <none> (no description available)
ii foomatic-db 20090616-1 OpenPrinting printer
support - dat
ii foomatic-db-engine 4.0-20090509-2.1 OpenPrinting printer
support - pro
pn hplip <none> (no description available)
pn smbclient <none> (no description available)
ii udev 157-1 /dev/ and hotplug
management daemo
pn xpdf-korean | xpdf-japa <none> (no description available)
-- Configuration Files:
/etc/cups/cupsd.conf [Errno 13] Permission denied: u'/etc/cups/cupsd.conf'
-- debconf information:
* cupsys/raw-print: true
* cupsys/backend: ipp, lpd, parallel, scsi, serial, socket, usb, snmp, dnssd
Reply to: