[Pkg-cups-devel] Bug#517665: Can't print with cups 1.3.9-14 unstable with postscript driver

Sun Mar 1 11:22:54 UTC 2009

Package: cups
Version: 1.3.9-14 (unstable)

Hello

I have a mix of debian testing and unstable (because I am slowly downgrading from unstable to testing by setting the priority maximal to testing in /etc/apt/preferences).
linux : 2.6.28-7.slh.1-sidux-686 (unstable)
libc6 : 2.7-18 (stable)

I still had the unstable version (1.3.9-14) of the cups packages, and I noticed that I wasn't able to print since a while in my HP LaserJet 4000 using the postscript driver. When trying to print a test page, my printer just told me that it was processing tasks but didn't print, even after half an hour.

Downgrading the following cups packages from the unstable version 1.3.9-14  to the stable version (1.3.8-1lenny4.1) fixed the problem :

cups
cups-bsd
cups-client
cups-common
cupsys-client
cupsys-common
libcups2

Here is what I get in /var/log/cups/error_log when trying to print the test page after I set the loglevel to debug in /etc/cups/cupsd.conf and BEFORE I downgraded cups :

D [01/Mar/2009:09:43:43 +0100] cupsdAcceptClient: 9 from localhost:631 (IPv4)
D [01/Mar/2009:09:43:43 +0100] cupsdReadClient: 9 GET /printers/test3?op=print-test-page HTTP/1.1
D [01/Mar/2009:09:43:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:09:43:43 +0100] [CGI] /usr/lib/cups/cgi-bin/printers.cgi started - PID = 3676
I [01/Mar/2009:09:43:43 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3676)
D [01/Mar/2009:09:43:43 +0100] cupsdSendCommand: 9 file=10
D [01/Mar/2009:09:43:43 +0100] cupsdAcceptClient: 12 from localhost (Domain)
D [01/Mar/2009:09:43:43 +0100] cupsdReadClient: 12 POST /printers/test3 HTTP/1.1
D [01/Mar/2009:09:43:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:09:43:43 +0100] Print-Job ipp://localhost:631/printers/test3
D [01/Mar/2009:09:43:43 +0100] Adding default job-sheets values "none,none"...
I [01/Mar/2009:09:43:43 +0100] [Job 109] Adding start banner page "none".
D [01/Mar/2009:09:43:43 +0100] Discarding unused job-created event...
I [01/Mar/2009:09:43:43 +0100] [Job 109] Adding end banner page "none".
I [01/Mar/2009:09:43:43 +0100] [Job 109] File of type application/postscript queued by "anonymous".
D [01/Mar/2009:09:43:43 +0100] [Job 109] hold_until=0
I [01/Mar/2009:09:43:43 +0100] [Job 109] Queued on "test3" by "anonymous".
D [01/Mar/2009:09:43:43 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2009:09:43:43 +0100] [Job 109] job-sheets=none,none
D [01/Mar/2009:09:43:43 +0100] [Job 109] banner_page = 0
D [01/Mar/2009:09:43:43 +0100] [Job 109] argv[0]="test3"
D [01/Mar/2009:09:43:43 +0100] [Job 109] argv[1]="109"
D [01/Mar/2009:09:43:43 +0100] [Job 109] argv[2]="anonymous"
D [01/Mar/2009:09:43:43 +0100] [Job 109] argv[3]="Test Page"
D [01/Mar/2009:09:43:43 +0100] [Job 109] argv[4]="1"
D [01/Mar/2009:09:43:43 +0100] [Job 109] argv[5]="job-uuid=urn:uuid:55b54213-0f6e-3483-791c-9f1c8268195d"
D [01/Mar/2009:09:43:43 +0100] [Job 109] argv[6]="/var/spool/cups/d00109-001"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[9]="SERVER_ADMIN=root at PC"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[10]="SOFTWARE=CUPS/1.3.9"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[12]="TZ=Europe/Zurich"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[13]="USER=root"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[16]="IPP_PORT=631"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[17]="CHARSET=utf-8"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[18]="LANG=fr.UTF8"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[19]="PPD=/etc/cups/ppd/test3.ppd"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[20]="RIP_MAX_CACHE=8m"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[21]="CONTENT_TYPE=application/postscript"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[22]="DEVICE_URI=socket://192.168.2.2"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[23]="PRINTER=test3"
D [01/Mar/2009:09:43:43 +0100] [Job 109] envp[24]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
I [01/Mar/2009:09:43:43 +0100] [Job 109] Started filter /usr/lib/cups/filter/pstopdf (PID 3677)
I [01/Mar/2009:09:43:43 +0100] [Job 109] Started filter /usr/lib/cups/filter/pdftopdf (PID 3678)
I [01/Mar/2009:09:43:43 +0100] [Job 109] Started filter /usr/lib/cups/filter/cpdftocps (PID 3679)
I [01/Mar/2009:09:43:43 +0100] [Job 109] Started backend /usr/lib/cups/backend/socket (PID 3680)
D [01/Mar/2009:09:43:43 +0100] Discarding unused job-state-changed event...
D [01/Mar/2009:09:43:43 +0100] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [01/Mar/2009:09:43:43 +0100] [Job 109] pstopdf 6 args: 109 anonymous Test Page 1 job-uuid=urn:uuid:55b54213-0f6e-3483-791c-9f1c8268195d /var/spool/cups/d00109-001
D [01/Mar/2009:09:43:43 +0100] [Job 109] PPD: /etc/cups/ppd/test3.ppd
D [01/Mar/2009:09:43:43 +0100] PID 3676 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [01/Mar/2009:09:43:43 +0100] cupsdCloseClient: 12
D [01/Mar/2009:09:43:43 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:43 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:43 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:43 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2009:09:43:43 +0100] [Job 109] Connected to 192.168.2.2:9100 (IPv4)...
D [01/Mar/2009:09:43:43 +0100] [Job 109] backendRunLoop(print_fd=0, device_fd=5, use_bc=1, side_cb=0xb8032fc0)
D [01/Mar/2009:09:43:43 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2009:09:43:43 +0100] [Job 109] Resolution: 600x600
D [01/Mar/2009:09:43:43 +0100] [Job 109] PPD options: -r600x600
D [01/Mar/2009:09:43:43 +0100] [Job 109] PostScript to be injected:
D [01/Mar/2009:09:43:43 +0100] [Job 109] Running cat | /usr/bin/ps2pdf13 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode                -dPDFSETTINGS=/printer -r600x600 - -
D [01/Mar/2009:09:43:44 +0100] [Job 109] GPL Ghostscript 8.63: Set UseCIEColor for UseDeviceIndependentColor to work properly.
D [01/Mar/2009:09:43:44 +0100] PID 3677 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [01/Mar/2009:09:43:44 +0100] PID 3678 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [01/Mar/2009:09:43:44 +0100] [Job 109] perl: warning: Setting locale failed.
D [01/Mar/2009:09:43:44 +0100] [Job 109] perl: warning: Please check that your locale settings:
D [01/Mar/2009:09:43:44 +0100] [Job 109] LANGUAGE = (unset),
D [01/Mar/2009:09:43:44 +0100] [Job 109] LC_ALL = (unset),
D [01/Mar/2009:09:43:44 +0100] [Job 109] LANG = "fr.UTF8"
D [01/Mar/2009:09:43:44 +0100] [Job 109] are supported and installed on your system.
D [01/Mar/2009:09:43:44 +0100] [Job 109] perl: warning: Falling back to the standard locale ("C").
D [01/Mar/2009:09:43:44 +0100] [Job 109] Device copies: 1; device collate:
D [01/Mar/2009:09:43:44 +0100] [Job 109] pdftops - copying to temp print file "/var/spool/cups/tmp/49aa4ac0c4c67"
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** Warning: File has a corrupted %%EOF marker, or garbage after %%EOF.
D [01/Mar/2009:09:43:45 +0100] [Job 109] Page = 595x842; 13,12 to 582,830
D [01/Mar/2009:09:43:45 +0100] [Job 109] slow_collate=0, slow_duplex=0, slow_order=0
D [01/Mar/2009:09:43:45 +0100] [Job 109] Before copy_comments - %!PS-Adobe-3.0
D [01/Mar/2009:09:43:45 +0100] [Job 109] %!PS-Adobe-3.0
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%Pages: (atend)
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%BoundingBox: (atend)
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%HiResBoundingBox: (atend)
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%Creator: GPL Ghostscript 863 (pswrite)
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%CreationDate: 2009/03/01 09:43:45
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%DocumentData: Clean7Bit
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%LanguageLevel: 2
D [01/Mar/2009:09:43:45 +0100] [Job 109] %%EndComments
D [01/Mar/2009:09:43:45 +0100] [Job 109] Before copy_prolog - %%BeginProlog
D [01/Mar/2009:09:43:45 +0100] [Job 109] Before copy_setup - %%Page: 1 1
D [01/Mar/2009:09:43:45 +0100] [Job 109] Before page loop - %%Page: 1 1
D [01/Mar/2009:09:43:45 +0100] [Job 109] Copying page 1...
D [01/Mar/2009:09:43:45 +0100] Discarding unused job-progress event...
D [01/Mar/2009:09:43:45 +0100] [Job 109] pagew = 568.3, pagel = 817.7
D [01/Mar/2009:09:43:45 +0100] [Job 109] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [01/Mar/2009:09:43:45 +0100] [Job 109] PageLeft = 13.4, PageRight = 581.8
D [01/Mar/2009:09:43:45 +0100] [Job 109] PageTop = 829.7, PageBottom = 12.1
D [01/Mar/2009:09:43:45 +0100] [Job 109] PageWidth = 595.0, PageLength = 842.0
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 8192 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 8192 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 8192 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 8192 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 8192 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109]
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** This file had errors that were repaired or ignored.
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** The file was produced by:
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** >>>> pdftopdf <<<<
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** Please notify the author of the software that produced this
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** file that it does not conform to Adobe's published PDF
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** specification.
D [01/Mar/2009:09:43:45 +0100] [Job 109]
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 1 pages...
D [01/Mar/2009:09:43:45 +0100] PID 3679 (/usr/lib/cups/filter/cpdftocps) exited with no errors.
D [01/Mar/2009:09:43:45 +0100] cupsdAcceptClient: 12 from localhost:631 (IPv4)
D [01/Mar/2009:09:43:45 +0100] cupsdReadClient: 12 GET /printers/test3 HTTP/1.1
D [01/Mar/2009:09:43:45 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:09:43:45 +0100] [CGI] /usr/lib/cups/cgi-bin/printers.cgi started - PID = 3711
I [01/Mar/2009:09:43:45 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=3711)
D [01/Mar/2009:09:43:45 +0100] cupsdSendCommand: 12 file=14
D [01/Mar/2009:09:43:45 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [01/Mar/2009:09:43:45 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2009:09:43:45 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:09:43:45 +0100] CUPS-Get-Default
D [01/Mar/2009:09:43:45 +0100] CUPS-Get-Default client-error-not-found: Pas d’imprimante par défaut
D [01/Mar/2009:09:43:45 +0100] cupsdProcessIPPRequest: 15 status_code=406 (client-error-not-found)
D [01/Mar/2009:09:43:45 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2009:09:43:45 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:09:43:45 +0100] Get-Printer-Attributes ipp://localhost/printers/test3
D [01/Mar/2009:09:43:45 +0100] cupsdProcessIPPRequest: 15 status_code=0 (successful-ok)
D [01/Mar/2009:09:43:45 +0100] [CGI] show_printer(http=0xb96dfef8, printer="test3")
D [01/Mar/2009:09:43:45 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2009:09:43:45 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:09:43:45 +0100] Get-Jobs ipp://localhost:631/printers/test3
D [01/Mar/2009:09:43:45 +0100] cupsdProcessIPPRequest: 15 status_code=0 (successful-ok)
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] cupsdCloseClient: 15
D [01/Mar/2009:09:43:45 +0100] PID 3711 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:09:43:45 +0100] [CGI] lang="fr.UTF8", locale="/fr"...

Here is what I get in /var/log/cups/error_log when trying to print the test page after I set the loglevel to debug in /etc/cups/cupsd.conf and AFTER I downgraded cups :

D [01/Mar/2009:12:15:54 +0100] cupsdAcceptClient: 12 from localhost:631 (IPv4)
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 12 GET /printers/Imprimante_noir_blanc HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] [CGI] /usr/lib/cups/cgi-bin/printers.cgi started - PID = 8640
I [01/Mar/2009:12:15:54 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=8640)
D [01/Mar/2009:12:15:54 +0100] cupsdSendCommand: 12 file=15
D [01/Mar/2009:12:15:54 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] CUPS-Get-Default
D [01/Mar/2009:12:15:54 +0100] CUPS-Get-Default client-error-not-found: Pas d’imprimante par défaut
D [01/Mar/2009:12:15:54 +0100] cupsdProcessIPPRequest: 16 status_code=406 (client-error-not-found)
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] Get-Printer-Attributes ipp://localhost/printers/Imprimante_noir_blanc
D [01/Mar/2009:12:15:54 +0100] cupsdProcessIPPRequest: 16 status_code=0 (successful-ok)
D [01/Mar/2009:12:15:54 +0100] [CGI] show_printer(http=0x923def0, printer="Imprimante_noir_blanc")
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] Get-Jobs ipp://localhost:631/printers/Imprimante_noir_blanc
D [01/Mar/2009:12:15:54 +0100] cupsdProcessIPPRequest: 16 status_code=0 (successful-ok)
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] PID 8640 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [01/Mar/2009:12:15:54 +0100] cupsdCloseClient: 16
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] [CGI] lang="fr.UTF8", locale="/fr"...
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 9 GET /cups.css HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdAcceptClient: 15 from localhost:631 (IPv4)
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 15 GET /images/top-left.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 12 GET /images/top-middle.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 10 GET /images/top-right.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 9 GET /images/tab-left.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 12 GET /images/tab-right.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 15 GET /images/printer-idle.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 10 GET /images/button-print-test-page.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 9 GET /images/button-stop-printer.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 15 GET /images/button-reject-jobs.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 12 GET /images/button-move-jobs.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 10 GET /images/button-cancel-all-jobs.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 9 GET /images/button-unpublish-printer.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:54 +0100] cupsdReadClient: 15 GET /images/button-modify-printer.gif HTTP/1.1
D [01/Mar/2009:12:15:54 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 12 GET /images/button-set-printer-options.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 10 GET /images/button-delete-printer.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 9 GET /images/button-set-as-default.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 15 GET /images/button-set-allowed-users.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 12 GET /images/button-clear.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 10 GET /images/button-show-completed.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 9 GET /images/button-show-all.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 15 GET /images/button-sort-descending.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 12 GET /images/button-restart-job.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 10 GET /images/button-cancel-job.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 9 GET /images/button-move-job.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 15 GET /images/bottom-left.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 12 GET /images/bottom-right.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2009:12:15:55 +0100] cupsdReadClient: 10 GET /images/button-search.gif HTTP/1.1
D [01/Mar/2009:12:15:55 +0100] cupsdAuthorize: No authentication data provided.

Here is what I think is the more interesting lines in the error_log before I downgraded cups :

D [01/Mar/2009:09:43:44 +0100] [Job 109] pdftops - copying to temp print file "/var/spool/cups/tmp/49aa4ac0c4c67"
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** Warning: File has a corrupted %%EOF marker, or garbage after %%EOF.

and these lines too :

D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Read 4096 bytes of print data...
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 4096 bytes of print data...
( ... )
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** This file had errors that were repaired or ignored.
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** The file was produced by:
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** >>>> pdftopdf <<<<
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** Please notify the author of the software that produced this
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** file that it does not conform to Adobe's published PDF
D [01/Mar/2009:09:43:45 +0100] [Job 109] **** specification.
D [01/Mar/2009:09:43:45 +0100] [Job 109]
D [01/Mar/2009:09:43:45 +0100] [Job 109] Wrote 1 pages...
D [01/Mar/2009:09:43:45 +0100] PID 3679 (/usr/lib/cups/filter/cpdftocps) exited with no errors.

Bye Jonas