And a log from working hpijs on trusty

D [18/Apr/2016:11:46:46 -0400] [Job 21] envp[19]="CHARSET=utf-8"
D [18/Apr/2016:11:46:46 -0400] [Job 21] envp[20]="LANG=en_US.UTF-8"
D [18/Apr/2016:11:46:46 -0400] [Job 21]
envp[21]="PPD=/etc/cups/ppd/HP_Officejet_J4500_series.ppd"
D [18/Apr/2016:11:46:46 -0400] [Job 21] envp[22]="RIP_MAX_CACHE=512k"
D [18/Apr/2016:11:46:46 -0400] [Job 21]
envp[23]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [18/Apr/2016:11:46:46 -0400] [Job 21]
envp[24]="DEVICE_URI=hp:/usb/Officejet_J4500_series?serial=CN9CHD31FB052T"
D [18/Apr/2016:11:46:46 -0400] [Job 21] envp[25]="PRINTER_INFO=HP
Officejet J4500 series"
D [18/Apr/2016:11:46:46 -0400] [Job 21] envp[26]="PRINTER_LOCATION="
D [18/Apr/2016:11:46:46 -0400] [Job 21]
envp[27]="PRINTER=HP_Officejet_J4500_series"
D [18/Apr/2016:11:46:46 -0400] [Job 21]
envp[28]="PRINTER_STATE_REASONS=marker-supply-low-warning"
D [18/Apr/2016:11:46:46 -0400] [Job 21] envp[29]="CUPS_FILETYPE=document"
D [18/Apr/2016:11:46:46 -0400] [Job 21]
envp[30]="FINAL_CONTENT_TYPE=printer/HP_Officejet_J4500_series"
D [18/Apr/2016:11:46:46 -0400] [Job 21] envp[31]="AUTH_I****"
I [18/Apr/2016:11:46:46 -0400] [Job 21] Started filter
/usr/lib/cups/filter/bannertopdf (PID 7597)
I [18/Apr/2016:11:46:46 -0400] [Job 21] Started filter
/usr/lib/cups/filter/pdftopdf (PID 7598)
I [18/Apr/2016:11:46:46 -0400] [Job 21] Started filter
/usr/lib/cups/filter/foomatic-rip (PID 7599)
I [18/Apr/2016:11:46:46 -0400] [Job 21] Started backend
/usr/lib/cups/backend/hp (PID 7600)
D [18/Apr/2016:11:46:46 -0400] Discarding unused job-state-changed event...
D [18/Apr/2016:11:46:46 -0400] [Client 17] Returning IPP successful-ok
for Print-Job (ipp://localhost:631/printers/HP_Officejet_J4500_series)
from localhost
D [18/Apr/2016:11:46:46 -0400] [Client 17] Content-Length: 174
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Client 17] cupsdWriteClient error=0,
used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=174, response=0x55b2473818d0(IPP_IDLE), pipe_pid=0, file=-1
D [18/Apr/2016:11:46:46 -0400] [Client 17] Writing IPP response,
ipp_state=DATA, old wused=0, new wused=0
D [18/Apr/2016:11:46:46 -0400] [Client 17] bytes=0, http_state=0,
data_remaining=0
D [18/Apr/2016:11:46:46 -0400] [Client 17] Waiting for request.
D [18/Apr/2016:11:46:46 -0400] cupsdSetBusyState: newbusy="Active
clients, printing jobs, and dirty files", busy="Active clients and dirty
files"
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
[snip]
D [18/Apr/2016:11:46:46 -0400] cupsdSetBusyState: newbusy="Printing jobs
and dirty files", busy="Active clients, printing jobs, and dirty files"
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Getting input from file
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] foomatic-rip version 1.0.52
running...
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Parsing PPD file ...
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option ColorSpace
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option Resolution
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option PageSize
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option Model
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option PrintoutMode
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option InputSlot
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option Duplex
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option DryTime
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option Quality
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option ImageableArea
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option PaperDimension
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Added option Font
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Parameter Summary
D [18/Apr/2016:11:46:46 -0400] [Job 21] -----------------
D [18/Apr/2016:11:46:46 -0400] [Job 21] Spooler: cups
D [18/Apr/2016:11:46:46 -0400] [Job 21] Printer: HP_Officejet_J4500_series
D [18/Apr/2016:11:46:46 -0400] [Job 21] Shell: /bin/bash
D [18/Apr/2016:11:46:46 -0400] [Job 21] PPD file:
/etc/cups/ppd/HP_Officejet_J4500_series.ppd
D [18/Apr/2016:11:46:46 -0400] [Job 21] ATTR file:
D [18/Apr/2016:11:46:46 -0400] [Job 21] Printer model: HP Officejet
j4500 Series hpijs, 3.14.3
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Job title: Test Page
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] File(s) to be printed:
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] <STDIN>
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Ghostscript extra search path
('GS_LIB'): /usr/share/cups/fonts
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Printing system options:
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Pondering option
'job-uuid=urn:uuid:0e2be3b3-5d3b-3c79-4707-42f6bbd546c2'
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Unknown option
job-uuid=urn:uuid:0e2be3b3-5d3b-3c79-4707-42f6bbd546c2.
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Pondering option
'job-originating-host-name=localhost'
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Unknown option
job-originating-host-name=localhost.
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Pondering option
'time-at-creation=1460994406'
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Unknown option
time-at-creation=1460994406.
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Pondering option
'time-at-processing=1460994406'
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Unknown option
time-at-processing=1460994406.
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Options from the PPD file:
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21]
================================================
D [18/Apr/2016:11:46:46 -0400] [Job 21] File: <STDIN>
D [18/Apr/2016:11:46:46 -0400] [Job 21]
================================================
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] PDF template file doesn't have
form. It's okay.
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Filetype: PDF
D [18/Apr/2016:11:46:46 -0400] [Job 21] Storing temporary files in
/var/spool/cups/tmp
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] PID 7597
(/usr/lib/cups/filter/bannertopdf) exited with no errors.
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] PID 7598
(/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] File contains 1 pages
D [18/Apr/2016:11:46:46 -0400] [Job 21] Starting renderer with command:
gs -dFirstPage=1  -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE
-dNOINTERPOLATE -sDEVICE=ijs -sIjsServer=hpijs -dDEVICEWIDTHPOINTS=612
-dDEVICEHEIGHTPOINTS=792 -sDeviceManufacturer="HEWLETT-PACKARD"
-sDeviceModel="deskjet 5600" -dDuplex=false -r300
-sIjsParams=Quality:Quality=0,Quality:ColorMode=2,Quality:MediaType=0,Quality:PenSet=2,PS:MediaPosition=7
-dIjsUseOutputFD -sOutputFile=-   /var/spool/cups/tmp/foomatic-IUVX93
D [18/Apr/2016:11:46:46 -0400] [Job 21] Starting process "kid3"
(generation 1)
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Starting process "kid4"
(generation 2)
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] Starting process "renderer"
(generation 2)
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] JCL: %-12345X@PJL
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] <job data>
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:46 -0400] [Job 21] STATE: +marker-supply-low-warning
D [18/Apr/2016:11:46:46 -0400] cupsdMarkDirty(---J-)
D [18/Apr/2016:11:46:46 -0400] cupsdSetBusyState: newbusy="Printing jobs
and dirty files", busy="Printing jobs and dirty files"
D [18/Apr/2016:11:46:46 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:47 -0400] [Job 21] STATE: +connecting-to-device
D [18/Apr/2016:11:46:47 -0400] cupsdMarkDirty(---J-)
D [18/Apr/2016:11:46:47 -0400] cupsdSetBusyState: newbusy="Dirty files",
busy="Printing jobs and dirty files"
D [18/Apr/2016:11:46:47 -0400] Discarding unused printer-state-changed
event...
D [18/Apr/2016:11:46:47 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:47 -0400] [Job 21] STATE: -connecting-to-device
D [18/Apr/2016:11:46:47 -0400] cupsdMarkDirty(---J-)
D [18/Apr/2016:11:46:47 -0400] cupsdSetBusyState: newbusy="Printing jobs
and dirty files", busy="Dirty files"
D [18/Apr/2016:11:46:47 -0400] [Job 21] STATE:
-media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [18/Apr/2016:11:46:47 -0400] Discarding unused printer-state-changed
event...
D [18/Apr/2016:11:46:47 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:48 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:48 -0400] [Client 16] GET
/printers/HP_Officejet_J4500_series HTTP/1.1
D [18/Apr/2016:11:46:48 -0400] cupsdSetBusyState: newbusy="Active
clients, printing jobs, and dirty files", busy="Printing jobs and dirty
files"
[snip]
D [18/Apr/2016:11:46:48 -0400] [Client 18] 2.0 CUPS-Get-Default 1
D [18/Apr/2016:11:46:48 -0400] CUPS-Get-Default
D [18/Apr/2016:11:46:48 -0400] [Client 18] Returning IPP successful-ok
for CUPS-Get-Default (no URI) from localhost
D [18/Apr/2016:11:46:48 -0400] [Client 18] Content-Length: 154
D [18/Apr/2016:11:46:48 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:48 -0400] [Client 18] cupsdWriteClient error=0,
used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH,
data_remaining=154, response=0x55b247381900(IPP_IDLE), pipe_pid=0, file=-1
D [18/Apr/2016:11:46:48 -0400] [Client 18] Writing IPP response,
ipp_state=DATA, old wused=0, new wused=0
D [18/Apr/2016:11:46:48 -0400] [Client 18] bytes=0, http_state=0,
data_remaining=0
D [18/Apr/2016:11:46:48 -0400] [Client 18] Waiting for request.
D [18/Apr/2016:11:46:48 -0400] cupsdSetBusyState: newbusy="Active
clients, printing jobs, and dirty files", busy="Active clients, printing
jobs, and dirty files"
D [18/Apr/2016:11:46:48 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:48 -0400] [CGI] cgiSetVariable: DEFAULT_NAME="PDF"
D [18/Apr/2016:11:46:48 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:48 -0400] [CGI] cgiSetVariable:
DEFAULT_URI="/printers/PDF"
D [18/Apr/2016:11:46:48 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:48 -0400] [CGI] show_printer(http=0x55bef35c11d0,
printer="HP_Officejet_J4500_series")
D [18/Apr/2016:11:46:48 -0400] cupsd is not idle any more, canceling
shutdown.
D [18/Apr/2016:11:46:48 -0400] [Client 18] POST / HTTP/1.1
D [18/Apr/2016:11:46:48 -0400] cupsdSetBusyState: newbusy="Active
clients, printing jobs, and dirty files", busy="Active clients, printing
jobs, and dirty files"
D [18/Apr/2016:11:46:48 -0400] [Client 18] No authentication data provided.

-- 
You received this bug notification because you are a member of Desktop
Packages, which is subscribed to cups in Ubuntu.
https://bugs.launchpad.net/bugs/1571511

Title:
  hpcups ppd fails to print; hpijs ppd works (hplip printer)

Status in cups package in Ubuntu:
  New
Status in hplip package in Ubuntu:
  New

Bug description:
  The hplip in xenial is not compatible with the versions of cups and
  dbus (and various other libraries) in xenial.

  The initial symptoms were that after running hp-setup -i (text mode
  only box), and attempting to print a test page from hplip, there was
  no output.  After cancelling that job from http://<host>:631/... and
  attempting to print another test page from the CUPS interface, CUPS
  reporter 'filter failed'.

  Reviewing error_log revealed the message 'unable to open inital
  device. quitting'.

  While this *sounds* like a device error, hp-levels and hp-clean both
  work, so clearly the issue is not with access to the usb device (and
  the appropriate /dev/bus/usb/*/* device has group lp and group rw
  permissions).

  Also some web searching reveals that this can be caused by e.g.
  ghostscript errors and is not necessarily indicative of an hardware
  device access issue.

  Running hp-doctor gives the attached result

  hplip version 3.16.3+repack0-1
  cups 2.1.3-4
  dbus 1.10.6-1ubuntu3

  On an up-to-date as of 2016-04-18 01:00:00 -0400 Xenial system
  installed from final beta alternate CD.

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/cups/+bug/1571511/+subscriptions

-- 
Mailing list: https://launchpad.net/~desktop-packages
Post to     : desktop-packages@lists.launchpad.net
Unsubscribe : https://launchpad.net/~desktop-packages
More help   : https://help.launchpad.net/ListHelp

Reply via email to