Package: cups Version: 1.6.3-1 Severity: important My printer setup is currently this:
- Server: old Pentium box running Wheezy (CUPS 1.5), and a Delcop CL3005W (rebadged Konica-Minolta magicolor 1600W) USB printer (driver: foo2lava) - Clients: a mix of Wheezy, Jessie (CUPS 1.6) and Windows XP/7 laptops. On the Windows clients, the native Konica-Minolta drivers were used. On the Debian clients, a local queue was created due to performance issues with the foo2lava driver on the old Pentium box (expected, as the driver is quite resource- intensive), so the print data is crunched on the clients, then sent as a raw print job to the server (which does nothing but to dump it directly to the printer in its native LAVAFLOW format) The problem with my Jessie/CUPS 1.6 clients is that they can't print to the Wheezy/CUPS 1.5 printserver. After enabling debug logging on everything (including the printserver, a Wheezy client which can print, and a Jessie client that CAN'T print), I've noticed that while the Wheezy (and Windows) clients send the print job data as "application/octet-stream" (so the server does nothing but to directly pipe the data into the printer), while the exact same data (LAVAFLOW encapsulted into PJL) is sent by the Jessie clients as "application/vnd.cups-pdf" (the server assumes that it's receiving a PDF... and obviously fails to rasterize something that it isn't a REAL PDF), which leads to a aborted print job and a failed foomatic-rip process. Relevant log entries from the Wheezy print server: - This Wheezy client can print: D [16/Aug/2013:22:30:06 -04-30] Create-Job ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:30:06 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" D [16/Aug/2013:22:30:06 -04-30] add_job: requesting-user-name="tomman" D [16/Aug/2013:22:30:06 -04-30] Adding default job-sheets values "none,none"... I [16/Aug/2013:22:30:06 -04-30] [Job 169] Adding start banner page "none". D [16/Aug/2013:22:30:06 -04-30] Discarding unused job-created event... I [16/Aug/2013:22:30:06 -04-30] [Job 169] Queued on "CL3005W" by "tomman". D [16/Aug/2013:22:30:06 -04-30] Returning IPP successful-ok for Create-Job (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.101 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 16 POST /printers/CL3005W HTTP/1.1 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdAuthorize: No authentication data provided. D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 15 POST /printers/CL3005W HTTP/1.1 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdAuthorize: No authentication data provided. D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 15 2.0 Send-Document 1 D [16/Aug/2013:22:30:06 -04-30] Send-Document ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:30:06 -04-30] cupsdIsAuthorized: requesting-user- name="tomman" D [16/Aug/2013:22:30:06 -04-30] [Job 169] Auto-typing file... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Request file type is application /octet-stream. D [16/Aug/2013:22:30:06 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" I [16/Aug/2013:22:30:06 -04-30] [Job 169] File of type application/octet-stream queued by "tomman". I [16/Aug/2013:22:30:06 -04-30] [Job 169] Adding end banner page "none". D [16/Aug/2013:22:30:06 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:30:06 -04-30] [Job 169] job-sheets=none,none D [16/Aug/2013:22:30:06 -04-30] [Job 169] argv[0]="CL3005W" D [16/Aug/2013:22:30:06 -04-30] [Job 169] argv[1]="169" D [16/Aug/2013:22:30:06 -04-30] [Job 169] argv[2]="tomman" D [16/Aug/2013:22:30:06 -04-30] [Job 169] argv[3]="Historial - PayPal" D [16/Aug/2013:22:30:06 -04-30] [Job 169] argv[4]="1" D [16/Aug/2013:22:30:06 -04-30] [Job 169] argv[5]="job-uuid=urn:uuid:0510e2dd- 4a0d-3fda-558c-ea1251b91f2e job-originating-host-name=192.168.0.101 time-at- creation=1376708406 time-at-processing=1376708406" D [16/Aug/2013:22:30:06 -04-30] [Job 169] argv[6]="/var/spool/cups/d00169-001" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[1]="CUPS_DATADIR=/usr/share/cups" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[2]="CUPS_DOCROOT=/usr/share/cups /doc-root" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[6]="CUPS_SERVERROOT=/etc/cups" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[7]="CUPS_STATEDIR=/var/run/cups" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[8]="HOME=/var/spool/cups/tmp" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[10]="SERVER_ADMIN=root@saki" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[11]="SOFTWARE=CUPS/1.5.3" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[12]="TMPDIR=/var/spool/cups/tmp" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[13]="TZ=America/Caracas" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[14]="USER=root" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[16]="CUPS_ENCRYPTION=IfRequested" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[17]="IPP_PORT=631" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[18]="CHARSET=utf-8" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[19]="LANG=es_VE.UTF-8" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[20]="PPD=/etc/cups/ppd/CL3005W.ppd" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[21]="RIP_MAX_CACHE=128m" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[22]="CONTENT_TYPE=application /octet-stream" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[23]="DEVICE_URI=usb://KONICA%20MINOLTA/mc1600W?serial=06796" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[24]="PRINTER_INFO=DELCOP CL3005W" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[25]="PRINTER_LOCATION=TSDX Base ETG" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[26]="PRINTER=CL3005W" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[27]="PRINTER_STATE_REASONS=none" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[28]="CUPS_FILETYPE=document" D [16/Aug/2013:22:30:06 -04-30] [Job 169] envp[29]="AUTH_I****" I [16/Aug/2013:22:30:06 -04-30] [Job 169] Started backend /usr/lib/cups/backend/usb (PID 3890) D [16/Aug/2013:22:30:06 -04-30] Discarding unused job-state-changed event... D [16/Aug/2013:22:30:06 -04-30] Returning IPP successful-ok for Send-Document (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.101 D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 16 2.0 Get-Jobs 1 D [16/Aug/2013:22:30:06 -04-30] Get-Jobs ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:30:06 -04-30] Returning IPP successful-ok for Get-Jobs (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.101 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 15 WAITING Closing on EOF D [16/Aug/2013:22:30:06 -04-30] cupsdCloseClient: 15 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdAcceptClient: 15 from 192.168.0.101:631 (IPv4) D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 15 POST /printers/CL3005W HTTP/1.1 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdAuthorize: No authentication data provided. D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 16 WAITING Closing on EOF D [16/Aug/2013:22:30:06 -04-30] cupsdCloseClient: 16 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [16/Aug/2013:22:30:06 -04-30] cupsdReadClient: 15 2.0 Get-Job-Attributes 1 D [16/Aug/2013:22:30:06 -04-30] Get-Job-Attributes ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:30:06 -04-30] Returning IPP successful-ok for Get-Job- Attributes (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.101 D [16/Aug/2013:22:30:06 -04-30] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [16/Aug/2013:22:30:06 -04-30] [Job 169] Printing on printer with URI: usb://KONICA%20MINOLTA/mc1600W?serial=06796 D [16/Aug/2013:22:30:06 -04-30] [Job 169] libusb_get_device_list=5 D [16/Aug/2013:22:30:06 -04-30] [Job 169] STATE: +connecting-to-device D [16/Aug/2013:22:30:06 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:30:06 -04-30] [Job 169] STATE: -connecting-to-device D [16/Aug/2013:22:30:06 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Device protocol: 2 I [16/Aug/2013:22:30:06 -04-30] [Job 169] Enviando datos a la impresora. D [16/Aug/2013:22:30:06 -04-30] [Job 169] Set job-printer-state-message to "Enviando datos a la impresora.", current level=INFO D [16/Aug/2013:22:30:06 -04-30] Discarding unused job-progress event... D [16/Aug/2013:22:30:06 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:30:06 -04-30] [Job 169] PAGE: 1 1 D [16/Aug/2013:22:30:06 -04-30] Discarding unused job-progress event... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Read 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Wrote 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sending print file, 8192 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Read 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Wrote 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sending print file, 16384 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Read 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Wrote 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sending print file, 24576 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Read 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Wrote 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sending print file, 32768 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Read 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Wrote 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sending print file, 40960 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Read 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Wrote 8192 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sending print file, 49152 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Read 511 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Wrote 511 bytes of print data... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sending print file, 49663 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Sent 49663 bytes... D [16/Aug/2013:22:30:06 -04-30] [Job 169] Waiting for read thread to exit... - On the other side, this Jessie client can't print at all on the same server D [16/Aug/2013:22:38:33 -04-30] Create-Job ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:38:33 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" D [16/Aug/2013:22:38:33 -04-30] add_job: requesting-user-name="tomman" D [16/Aug/2013:22:38:33 -04-30] Adding default job-sheets values "none,none"... I [16/Aug/2013:22:38:33 -04-30] [Job 171] Adding start banner page "none". D [16/Aug/2013:22:38:33 -04-30] Discarding unused job-created event... I [16/Aug/2013:22:38:33 -04-30] [Job 171] Queued on "CL3005W" by "tomman". D [16/Aug/2013:22:38:33 -04-30] Returning IPP successful-ok for Create-Job (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.102 D [16/Aug/2013:22:38:33 -04-30] cupsdReadClient: 16 2.0 Get-Jobs 5 D [16/Aug/2013:22:38:33 -04-30] Get-Jobs ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:38:33 -04-30] Returning IPP successful-ok for Get-Jobs (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.102 D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdReadClient: 15 POST /printers/CL3005W HTTP/1.1 D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdAuthorize: No authentication data provided. D [16/Aug/2013:22:38:33 -04-30] cupsdReadClient: 15 2.0 Send-Document 6 D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdReadClient: 16 WAITING Closing on EOF D [16/Aug/2013:22:38:33 -04-30] cupsdCloseClient: 16 D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] Send-Document ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:38:33 -04-30] cupsdIsAuthorized: requesting-user- name="tomman" D [16/Aug/2013:22:38:33 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" I [16/Aug/2013:22:38:33 -04-30] [Job 171] File of type application/vnd.cups-pdf queued by "tomman". I [16/Aug/2013:22:38:33 -04-30] [Job 171] Adding end banner page "none". D [16/Aug/2013:22:38:33 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdMarkDirty(----J-) D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:38:33 -04-30] [Job 171] job-sheets=none,none D [16/Aug/2013:22:38:33 -04-30] [Job 171] argv[0]="CL3005W" D [16/Aug/2013:22:38:33 -04-30] [Job 171] argv[1]="171" D [16/Aug/2013:22:38:33 -04-30] [Job 171] argv[2]="tomman" D [16/Aug/2013:22:38:33 -04-30] [Job 171] argv[3]="Historial - PayPal" D [16/Aug/2013:22:38:33 -04-30] [Job 171] argv[4]="1" D [16/Aug/2013:22:38:33 -04-30] [Job 171] argv[5]="ColorMode=ICM Duplex=None halftone=default ICM=km1600-default InputSlot=Auto job-originating-host- name=192.168.0.102 job-uuid=urn:uuid:12b31394-66df-3d2c-59e5-01e5dd79517c MediaType=plain number-up=1 NupOrient=port NupPages=1up PageSize=Letter Quality=draft Resolution=600x600dpi time-at-creation=1376708913 time-at- processing=1376708913" D [16/Aug/2013:22:38:33 -04-30] [Job 171] argv[6]="/var/spool/cups/d00171-001" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[1]="CUPS_DATADIR=/usr/share/cups" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[2]="CUPS_DOCROOT=/usr/share/cups /doc-root" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[6]="CUPS_SERVERROOT=/etc/cups" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[7]="CUPS_STATEDIR=/var/run/cups" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[8]="HOME=/var/spool/cups/tmp" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[10]="SERVER_ADMIN=root@saki" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[11]="SOFTWARE=CUPS/1.5.3" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[12]="TMPDIR=/var/spool/cups/tmp" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[13]="TZ=America/Caracas" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[14]="USER=root" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[16]="CUPS_ENCRYPTION=IfRequested" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[17]="IPP_PORT=631" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[18]="CHARSET=utf-8" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[19]="LANG=es_VE.UTF-8" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[20]="PPD=/etc/cups/ppd/CL3005W.ppd" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[21]="RIP_MAX_CACHE=128m" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[23]="DEVICE_URI=usb://KONICA%20MINOLTA/mc1600W?serial=06796" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[24]="PRINTER_INFO=DELCOP CL3005W" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[25]="PRINTER_LOCATION=TSDX Base ETG" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[26]="PRINTER=CL3005W" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[27]="PRINTER_STATE_REASONS=none" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[28]="CUPS_FILETYPE=document" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[29]="FINAL_CONTENT_TYPE=printer/CL3005W" D [16/Aug/2013:22:38:33 -04-30] [Job 171] envp[30]="AUTH_I****" I [16/Aug/2013:22:38:33 -04-30] [Job 171] Started filter /usr/lib/cups/filter /foomatic-rip (PID 3923) I [16/Aug/2013:22:38:33 -04-30] [Job 171] Started backend /usr/lib/cups/backend/usb (PID 3924) D [16/Aug/2013:22:38:33 -04-30] Discarding unused job-state-changed event... D [16/Aug/2013:22:38:33 -04-30] Returning IPP successful-ok for Send-Document (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.102 D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdReadClient: 15 WAITING Closing on EOF D [16/Aug/2013:22:38:33 -04-30] cupsdCloseClient: 15 D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdAcceptClient: 15 from 192.168.0.102:631 (IPv4) D [16/Aug/2013:22:38:33 -04-30] cupsdReadClient: 15 POST /printers/CL3005W HTTP/1.1 D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [16/Aug/2013:22:38:33 -04-30] cupsdAuthorize: No authentication data provided. D [16/Aug/2013:22:38:33 -04-30] [Job 171] Getting input from file /var/spool/cups/d00171-001 D [16/Aug/2013:22:38:33 -04-30] cupsdReadClient: 15 2.0 Get-Job-Attributes 7 D [16/Aug/2013:22:38:33 -04-30] Get-Job-Attributes ipp://saki.tomman.net.ve:631/printers/CL3005W D [16/Aug/2013:22:38:33 -04-30] Returning IPP successful-ok for Get-Job- Attributes (ipp://saki.tomman.net.ve:631/printers/CL3005W) from 192.168.0.102 D [16/Aug/2013:22:38:33 -04-30] [Job 171] foomatic-rip version 4.0.17.256 running... D [16/Aug/2013:22:38:33 -04-30] [Job 171] Parsing PPD file ... D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option ColorSpace D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option PageSize D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option Quality D [16/Aug/2013:22:38:33 -04-30] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option PrinterType D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option ColorMode D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option Resolution D [16/Aug/2013:22:38:33 -04-30] [Job 171] Printing on printer with URI: usb://KONICA%20MINOLTA/mc1600W?serial=06796 D [16/Aug/2013:22:38:33 -04-30] [Job 171] libusb_get_device_list=5 D [16/Aug/2013:22:38:33 -04-30] [Job 171] STATE: +connecting-to-device D [16/Aug/2013:22:38:33 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option ImageableArea D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option PaperDimension D [16/Aug/2013:22:38:33 -04-30] [Job 171] STATE: -connecting-to-device D [16/Aug/2013:22:38:33 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option InputSlot D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option MediaType D [16/Aug/2013:22:38:33 -04-30] [Job 171] Device protocol: 2 D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option Duplex D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option Copies I [16/Aug/2013:22:38:33 -04-30] [Job 171] Enviando datos a la impresora. D [16/Aug/2013:22:38:33 -04-30] [Job 171] Set job-printer-state-message to "Enviando datos a la impresora.", current level=INFO D [16/Aug/2013:22:38:33 -04-30] Discarding unused job-progress event... D [16/Aug/2013:22:38:33 -04-30] Discarding unused printer-state-changed event... D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option halftone D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option ICM D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option NupOrient D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option NupPages D [16/Aug/2013:22:38:33 -04-30] [Job 171] Added option Font D [16/Aug/2013:22:38:33 -04-30] [Job 171] D [16/Aug/2013:22:38:33 -04-30] [Job 171] Parameter Summary D [16/Aug/2013:22:38:33 -04-30] [Job 171] ----------------- D [16/Aug/2013:22:38:33 -04-30] [Job 171] D [16/Aug/2013:22:38:33 -04-30] [Job 171] Spooler: cups D [16/Aug/2013:22:38:33 -04-30] [Job 171] Printer: CL3005W D [16/Aug/2013:22:38:33 -04-30] [Job 171] Shell: /bin/bash D [16/Aug/2013:22:38:33 -04-30] [Job 171] PPD file: /etc/cups/ppd/CL3005W.ppd D [16/Aug/2013:22:38:33 -04-30] [Job 171] ATTR file: D [16/Aug/2013:22:38:33 -04-30] [Job 171] Printer model: KONICA MINOLTA magicolor 1600W Foomatic/foo2lava (recommended) D [16/Aug/2013:22:38:33 -04-30] [Job 171] Job title: Historial - PayPal D [16/Aug/2013:22:38:33 -04-30] [Job 171] File(s) to be printed: D [16/Aug/2013:22:38:33 -04-30] [Job 171] /var/spool/cups/d00171-001 D [16/Aug/2013:22:38:33 -04-30] [Job 171] D [16/Aug/2013:22:38:34 -04-30] [Job 171] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts D [16/Aug/2013:22:38:34 -04-30] [Job 171] Printing system options: D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'job-originating- host-name=192.168.0.102' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Unknown option job-originating-host- name=192.168.0.102. D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'job- uuid=urn:uuid:12b31394-66df-3d2c-59e5-01e5dd79517c' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Unknown option job- uuid=urn:uuid:12b31394-66df-3d2c-59e5-01e5dd79517c. D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'number-up=1' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Unknown option number-up=1. D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'time-at- creation=1376708913' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Unknown option time-at- creation=1376708913. D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'time-at- processing=1376708913' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Unknown option time-at- processing=1376708913. D [16/Aug/2013:22:38:34 -04-30] [Job 171] Options from the PPD file: D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'ColorMode=ICM' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'Duplex=None' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'halftone=default' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'ICM=km1600-default' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'InputSlot=Auto' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'MediaType=plain' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'NupOrient=port' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'NupPages=1up' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'PageSize=Letter' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'Quality=draft' D [16/Aug/2013:22:38:34 -04-30] [Job 171] Pondering option 'Resolution=600x600dpi' D [16/Aug/2013:22:38:34 -04-30] [Job 171] D [16/Aug/2013:22:38:34 -04-30] [Job 171] ================================================ D [16/Aug/2013:22:38:34 -04-30] [Job 171] D [16/Aug/2013:22:38:34 -04-30] [Job 171] File: /var/spool/cups/d00171-001 D [16/Aug/2013:22:38:34 -04-30] [Job 171] D [16/Aug/2013:22:38:34 -04-30] [Job 171] ================================================ D [16/Aug/2013:22:38:34 -04-30] [Job 171] D [16/Aug/2013:22:38:34 -04-30] [Job 171] Cannot process "/var/spool/cups/d00171-001": Unknown filetype. D [16/Aug/2013:22:38:34 -04-30] [Job 171] Process is dying with "Could not print file /var/spool/cups/d00171-001 D [16/Aug/2013:22:38:34 -04-30] [Job 171] ", exit stat 2 D [16/Aug/2013:22:38:34 -04-30] [Job 171] Cleaning up... D [16/Aug/2013:22:38:34 -04-30] PID 3923 (/usr/lib/cups/filter/foomatic-rip) stopped with status 2. D [16/Aug/2013:22:38:34 -04-30] [Job 171] Sent 0 bytes... D [16/Aug/2013:22:38:34 -04-30] [Job 171] Waiting for read thread to exit... Sadly this means that my Jessie hosts are useless for printing. Even the quintessential CUPS test page fails on these! -- System Information: Debian Release: jessie/sid APT prefers testing APT policy: (990, 'testing'), (1, 'experimental') Architecture: amd64 (x86_64) Foreign Architectures: i386 Kernel: Linux 3.10-2-amd64 (SMP w/4 CPU cores) Locale: LANG=es_VE.UTF-8, LC_CTYPE=es_VE.UTF-8 (charmap=UTF-8) Shell: /bin/sh linked to /bin/dash Versions of packages cups depends on: ii cups-client 1.6.3-1 ii cups-common 1.6.3-1 ii cups-daemon 1.6.3-1 ii cups-filters 1.0.34-3+b1 ii cups-ppdc 1.6.3-1 ii cups-server-common 1.6.3-1 ii debconf [debconf-2.0] 1.5.50 ii ghostscript 9.05~dfsg-8 ii libavahi-client3 0.6.31-2 ii libavahi-common3 0.6.31-2 ii libc-bin 2.17-92 ii libc6 2.17-92 ii libcups2 1.6.3-1 ii libcupscgi1 1.6.3-1 ii libcupsimage2 1.6.3-1 ii libcupsmime1 1.6.3-1 ii libcupsppdc1 1.6.3-1 ii libgcc1 1:4.8.1-2 ii libstdc++6 4.8.1-2 ii libusb-1.0-0 2:1.0.16-3 ii lsb-base 4.1+Debian12 ii poppler-utils 0.18.4-6 ii procps 1:3.3.4-2 Versions of packages cups recommends: ii avahi-daemon 0.6.31-2 ii colord 1.0.2-1 ii foomatic-filters 4.0.17-1 ii ghostscript-cups 9.05~dfsg-8 ii printer-driver-gutenprint 5.2.9-1 Versions of packages cups suggests: ii cups-bsd 1.6.3-1 pn cups-pdf <none> ii foomatic-db-compressed-ppds [foomatic-db] 20130609-1 ii hplip 3.13.4-1+b1 ii printer-driver-hpcups 3.13.4-1+b1 ii smbclient 2:3.6.17-1 ii udev 175-7.2 -- debconf information: cupsys/raw-print: true cupsys/backend: lpd, socket, usb, snmp, dnssd -- To UNSUBSCRIBE, email to debian-bugs-dist-requ...@lists.debian.org with a subject of "unsubscribe". Trouble? Contact listmas...@lists.debian.org