Hi,
I have installed cups(1.5.3) in my Beagleboard black based custom hardware running on Debian 7.8 using ‘apt-get install’ command. I am trying to print to HP deskjet 1112 usb printer from system line but nothing is getting printed and the output of ‘lpstat -t’ shows the error : " /usr/lib/cups/filter/hpcups failed "
The error_log output is :
I [10/Nov/2015:09:44:51 +0000] Saving job.cache…
I [10/Nov/2015:09:44:52 +0000] Listening to [v1.::1]:631 (IPv6)
I [10/Nov/2015:09:44:52 +0000] Listening to 127.0.0.1:631 (IPv4)
I [10/Nov/2015:09:44:52 +0000] Listening to /var/run/cups/cups.sock (Domain)
I [10/Nov/2015:09:44:52 +0000] Remote access is disabled.
D [10/Nov/2015:09:44:52 +0000] Added auto ServerAlias beaglebone
I [10/Nov/2015:09:44:52 +0000] Loaded configuration file “/etc/cups/cupsd.conf”
I [10/Nov/2015:09:44:52 +0000] Using default TempDir of /var/spool/cups/tmp…
I [10/Nov/2015:09:44:52 +0000] Configured for up to 100 clients.
I [10/Nov/2015:09:44:52 +0000] Allowing up to 100 client connections per host.
I [10/Nov/2015:09:44:52 +0000] Using policy “default” as the default.
I [10/Nov/2015:09:44:52 +0000] Full reload is required.
I [10/Nov/2015:09:44:52 +0000] Loaded MIME database from “/usr/share/cups/mime” and “/etc/cups”: 39 types, 56 filters…
D [10/Nov/2015:09:44:52 +0000] Loading printer HP…
D [10/Nov/2015:09:44:52 +0000] load_ppd: Loading /var/cache/cups/HP.data…
D [10/Nov/2015:09:44:52 +0000] Calling DeleteDevice(cups-HP)
D [10/Nov/2015:09:44:52 +0000] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, (s)', does not match expected type (o)’
D [10/Nov/2015:09:44:52 +0000] Using profile id of HP-Gray…
D [10/Nov/2015:09:44:52 +0000] Calling CreateProfile(HP-Gray…,temp)
D [10/Nov/2015:09:44:52 +0000] created profile /org/freedesktop/ColorManager/profiles/HP_Gray__
D [10/Nov/2015:09:44:52 +0000] Using profile id of HP-RGB…
D [10/Nov/2015:09:44:52 +0000] Calling CreateProfile(HP-RGB…,temp)
D [10/Nov/2015:09:44:52 +0000] created profile /org/freedesktop/ColorManager/profiles/HP_RGB__
I [10/Nov/2015:09:44:52 +0000] Registering ICC color profiles for “HP”
D [10/Nov/2015:09:44:52 +0000] Calling CreateDevice(cups-HP,temp)
D [10/Nov/2015:09:44:52 +0000] created device /org/freedesktop/ColorManager/devices/cups_HP
D [10/Nov/2015:09:44:52 +0000] Calling /org/freedesktop/ColorManager/devices/cups_HP:AddProfile(/org/freedesktop/ColorManager/profiles/HP_Gray__) [soft]
D [10/Nov/2015:09:44:52 +0000] Calling /org/freedesktop/ColorManager/devices/cups_HP:AddProfile(/org/freedesktop/ColorManager/profiles/HP_RGB__) [soft]
D [10/Nov/2015:09:44:52 +0000] cupsdRegisterPrinter(p=0xb6feb638(HP))
I [10/Nov/2015:09:44:52 +0000] Loading job cache file “/var/cache/cups/job.cache”…
I [10/Nov/2015:09:44:52 +0000] Full reload complete.
D [10/Nov/2015:09:44:52 +0000] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [10/Nov/2015:09:44:52 +0000] Cleaning out old files in “/var/spool/cups/tmp”…
D [10/Nov/2015:09:44:52 +0000] cupsdCleanFiles(path="/var/cache/cups", pattern=".ipp")
I [10/Nov/2015:09:44:52 +0000] Cleaning out old files in “/var/cache/cups”…
E [10/Nov/2015:09:44:52 +0000] Unable to open listen socket for address [v1.::1]:631 - Address family not supported by protocol.
I [10/Nov/2015:09:44:52 +0000] Listening to 127.0.0.1:631 on fd 9…
I [10/Nov/2015:09:44:52 +0000] Listening to /var/run/cups/cups.sock:631 on fd 10…
I [10/Nov/2015:09:44:52 +0000] Resuming new connection processing…
D [10/Nov/2015:09:44:52 +0000] Avahi client started
D [10/Nov/2015:09:44:52 +0000] cupsdRegisterPrinter(p=0xb6feb638(HP))
D [10/Nov/2015:09:44:52 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Not busy”
D [10/Nov/2015:09:44:52 +0000] Discarding unused server-started event…
D [10/Nov/2015:09:44:53 +0000] Report: clients=0
D [10/Nov/2015:09:44:53 +0000] Report: jobs=0
D [10/Nov/2015:09:44:53 +0000] Report: jobs-active=0
D [10/Nov/2015:09:44:53 +0000] Report: printers=1
D [10/Nov/2015:09:44:53 +0000] Report: printers-implicit=0
D [10/Nov/2015:09:44:53 +0000] Report: stringpool-string-count=2200
D [10/Nov/2015:09:44:53 +0000] Report: stringpool-alloc-bytes=9256
D [10/Nov/2015:09:44:53 +0000] Report: stringpool-total-bytes=41544
D [10/Nov/2015:09:44:59 +0000] cupsdAcceptClient: 15 from localhost (Domain)
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:44:59 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:44:59 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:44:59 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:44:59 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [10/Nov/2015:09:44:59 +0000] CUPS-Get-Default
D [10/Nov/2015:09:44:59 +0000] CUPS-Get-Default client-error-not-found: No default printer.
D [10/Nov/2015:09:44:59 +0000] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:44:59 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:44:59 +0000] cupsdAcceptClient: 16 from localhost (Domain)
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 16 WAITING Closing on EOF
D [10/Nov/2015:09:44:59 +0000] cupsdCloseClient: 16
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Classes 1
D [10/Nov/2015:09:44:59 +0000] CUPS-Get-Classes
D [10/Nov/2015:09:44:59 +0000] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:44:59 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:44:59 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:44:59 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:44:59 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:44:59 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:44:59 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:44:59 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:44:59 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:44:59 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:44:59 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 1.1 Get-Jobs 1
D [10/Nov/2015:09:44:59 +0000] Get-Jobs ipp://localhost/
D [10/Nov/2015:09:44:59 +0000] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:44:59 +0000] cupsdReadClient: 15 WAITING Closing on EOF
D [10/Nov/2015:09:44:59 +0000] cupsdCloseClient: 15
D [10/Nov/2015:09:44:59 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Not busy”
D [10/Nov/2015:09:45:08 +0000] cupsdAcceptClient: 15 from localhost (Domain)
D [10/Nov/2015:09:45:08 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:45:08 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:08 +0000] cupsdReadClient: 15 1.1 Get-Printer-Attributes 1
D [10/Nov/2015:09:45:08 +0000] Get-Printer-Attributes ipp://localhost:631/printers/HP
D [10/Nov/2015:09:45:08 +0000] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/HP) from localhost
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Active clients”
D [10/Nov/2015:09:45:08 +0000] cupsdReadClient: 15 POST /printers/HP HTTP/1.1
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients”, busy=“Not busy”
D [10/Nov/2015:09:45:08 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:08 +0000] cupsdReadClient: 15 1.1 Create-Job 1
D [10/Nov/2015:09:45:08 +0000] Create-Job ipp://localhost:631/printers/HP
D [10/Nov/2015:09:45:08 +0000] cupsdMarkDirty(----J-)
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Active clients”
D [10/Nov/2015:09:45:08 +0000] add_job: requesting-user-name=“root”
I [10/Nov/2015:09:45:08 +0000] [Job 39] Adding start banner page “none”.
D [10/Nov/2015:09:45:08 +0000] Discarding unused job-created event…
I [10/Nov/2015:09:45:08 +0000] [Job 39] Queued on “HP” by “root”.
D [10/Nov/2015:09:45:08 +0000] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/HP) from localhost
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:08 +0000] cupsdReadClient: 15 POST /printers/HP HTTP/1.1
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Dirty files”
D [10/Nov/2015:09:45:08 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:08 +0000] cupsdReadClient: 15 1.1 Send-Document 1
D [10/Nov/2015:09:45:08 +0000] Send-Document ipp://localhost:631/printers/HP
D [10/Nov/2015:09:45:08 +0000] cupsdIsAuthorized: requesting-user-name=“root”
D [10/Nov/2015:09:45:08 +0000] [Job 39] Auto-typing file…
D [10/Nov/2015:09:45:08 +0000] [Job 39] Request file type is text/plain.
D [10/Nov/2015:09:45:08 +0000] cupsdMarkDirty(----J-)
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Active clients and dirty files”
I [10/Nov/2015:09:45:08 +0000] [Job 39] File of type text/plain queued by “root”.
I [10/Nov/2015:09:45:08 +0000] [Job 39] Adding end banner page “none”.
D [10/Nov/2015:09:45:08 +0000] cupsdMarkDirty(----J-)
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:08 +0000] cupsdMarkDirty(----J-)
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:08 +0000] Discarding unused printer-state-changed event…
D [10/Nov/2015:09:45:08 +0000] [Job 39] job-sheets=none,none
D [10/Nov/2015:09:45:08 +0000] [Job 39] argv[0]=“HP”
D [10/Nov/2015:09:45:08 +0000] [Job 39] argv[1]=“39”
D [10/Nov/2015:09:45:08 +0000] [Job 39] argv[2]=“root”
D [10/Nov/2015:09:45:08 +0000] [Job 39] argv[3]=“abc.txt”
D [10/Nov/2015:09:45:08 +0000] [Job 39] argv[4]=“1”
D [10/Nov/2015:09:45:08 +0000] [Job 39] argv[5]=“finishings=3 number-up=1 job-uuid=urn:uuid:1e507137-011d-38f5-5887-ae080a59a6e9 job-originating-host-name=localhost time-at-creation=1447148708 time-at-processing=1447148708”
D [10/Nov/2015:09:45:08 +0000] [Job 39] argv[6]="/var/spool/cups/d00039-001"
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[0]=“CUPS_CACHEDIR=/var/cache/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[1]=“CUPS_DATADIR=/usr/share/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[2]=“CUPS_DOCROOT=/usr/share/cups/doc-root”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[3]=“CUPS_FONTPATH=/usr/share/cups/fonts”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[4]=“CUPS_REQUESTROOT=/var/spool/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[5]=“CUPS_SERVERBIN=/usr/lib/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[6]=“CUPS_SERVERROOT=/etc/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[7]=“CUPS_STATEDIR=/var/run/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[8]=“HOME=/var/spool/cups/tmp”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[9]=“PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[10]=“SERVER_ADMIN=root at beaglebone”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[11]=“SOFTWARE=CUPS/1.5.3”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[12]=“TMPDIR=/var/spool/cups/tmp”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[13]=“TZ=Etc/UTC”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[14]=“USER=root”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[15]=“CUPS_SERVER=/var/run/cups/cups.sock”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[16]=“CUPS_ENCRYPTION=IfRequested”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[17]=“IPP_PORT=631”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[18]=“CHARSET=utf-8”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[19]=“LANG=en_US.UTF-8”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[20]=“PPD=/etc/cups/ppd/HP.ppd”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[21]=“RIP_MAX_CACHE=128m”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[22]=“CONTENT_TYPE=text/plain”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[23]=“DEVICE_URI=hp:/usb/DeskJet_1110_series?serial=CN55D1N02S065W”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[24]=“PRINTER_INFO=HP”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[25]=“PRINTER_LOCATION=”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[26]=“PRINTER=HP”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[27]=“PRINTER_STATE_REASONS=none”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[28]=“CUPS_FILETYPE=document”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[29]=“FINAL_CONTENT_TYPE=printer/HP”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[30]="AUTH_I***"
I [10/Nov/2015:09:45:08 +0000] [Job 39] Started filter /usr/lib/cups/filter/texttopdf (PID 22756)
I [10/Nov/2015:09:45:08 +0000] [Job 39] Started filter /usr/lib/cups/filter/pdftopdf (PID 22757)
I [10/Nov/2015:09:45:08 +0000] [Job 39] Started filter /usr/lib/cups/filter/gstoraster (PID 22758)
I [10/Nov/2015:09:45:08 +0000] [Job 39] Started filter /usr/lib/cups/filter/hpcups (PID 22759)
I [10/Nov/2015:09:45:08 +0000] [Job 39] Started backend /usr/lib/cups/backend/hp (PID 22760)
D [10/Nov/2015:09:45:08 +0000] Discarding unused job-state-changed event…
D [10/Nov/2015:09:45:08 +0000] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/HP) from localhost
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Printing jobs and dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:08 +0000] cupsdReadClient: 15 WAITING Closing on EOF
D [10/Nov/2015:09:45:08 +0000] cupsdCloseClient: 15
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Printing jobs and dirty files”, busy=“Printing jobs and dirty files”
D [10/Nov/2015:09:45:08 +0000] [Job 39] Page = 595x842; 8,41 to 587,833
D [10/Nov/2015:09:45:08 +0000] PID 22756 (/usr/lib/cups/filter/texttopdf) exited with no errors.
D [10/Nov/2015:09:45:08 +0000] [Job 39] PPD uses qualifier ‘RGB.Plain.’
D [10/Nov/2015:09:45:08 +0000] PID 22757 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [10/Nov/2015:09:45:08 +0000] [Job 39] Calling FindDeviceById(HP)
D [10/Nov/2015:09:45:08 +0000] [Job 39] Failed to send: org.freedesktop.ColorManager.Failed:device id ‘HP’ does not exists
D [10/Nov/2015:09:45:08 +0000] [Job 39] Failed to get profile filename!
I [10/Nov/2015:09:45:08 +0000] [Job 39] no profiles specified in PPD
D [10/Nov/2015:09:45:08 +0000] [Job 39] Set job-printer-state-message to “no profiles specified in PPD”, current level=INFO
D [10/Nov/2015:09:45:08 +0000] Discarding unused job-progress event…
D [10/Nov/2015:09:45:08 +0000] Discarding unused printer-state-changed event…
D [10/Nov/2015:09:45:08 +0000] [Job 39] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -sOutputType=0 -r600x600 -dMediaPosition=1 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=841 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=17 -dcupsInteger0=26 -scupsPageSizeName=A4 -I/usr/share/cups/fonts -c -f -_
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[0]=“CUPS_CACHEDIR=/var/cache/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[1]=“CUPS_DATADIR=/usr/share/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[2]=“CUPS_DOCROOT=/usr/share/cups/doc-root”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[3]=“CUPS_FONTPATH=/usr/share/cups/fonts”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[4]=“CUPS_REQUESTROOT=/var/spool/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[5]=“CUPS_SERVERBIN=/usr/lib/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[6]=“CUPS_SERVERROOT=/etc/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[7]=“CUPS_STATEDIR=/var/run/cups”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[8]=“HOME=/var/spool/cups/tmp”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[9]=“PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[10]=“SERVER_ADMIN=root at beaglebone”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[11]=“SOFTWARE=CUPS/1.5.3”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[12]=“TMPDIR=/var/spool/cups/tmp”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[13]=“TZ=Etc/UTC”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[14]=“USER=root”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[15]=“CUPS_SERVER=/var/run/cups/cups.sock”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[16]=“CUPS_ENCRYPTION=IfRequested”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[17]=“IPP_PORT=631”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[18]=“CHARSET=utf-8”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[19]=“LANG=en_US.UTF-8”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[20]=“PPD=/etc/cups/ppd/HP.ppd”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[21]=“RIP_MAX_CACHE=128m”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[22]=“CONTENT_TYPE=text/plain”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[23]=“DEVICE_URI=hp:/usb/DeskJet_1110_series?serial=CN55D1N02S065W”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[24]=“PRINTER_INFO=HP”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[25]=“PRINTER_LOCATION=”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[26]=“PRINTER=HP”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[27]=“PRINTER_STATE_REASONS=none”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[28]=“CUPS_FILETYPE=document”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[29]=“FINAL_CONTENT_TYPE=printer/HP”
D [10/Nov/2015:09:45:08 +0000] [Job 39] envp[30]=“AUTH_INFO_REQUIRED=none”
I [10/Nov/2015:09:45:08 +0000] [Job 39] Start rendering…
D [10/Nov/2015:09:45:08 +0000] [Job 39] Set job-printer-state-message to “Start rendering…”, current level=INFO
D [10/Nov/2015:09:45:08 +0000] Discarding unused job-progress event…
D [10/Nov/2015:09:45:08 +0000] Discarding unused printer-state-changed event…
I [10/Nov/2015:09:45:08 +0000] [Job 39] Processing page 1…
D [10/Nov/2015:09:45:08 +0000] [Job 39] Set job-printer-state-message to “Processing page 1…”, current level=INFO
D [10/Nov/2015:09:45:08 +0000] [Job 39] **** Unable to open the initial device, quitting.
D [10/Nov/2015:09:45:08 +0000] Discarding unused job-progress event…
D [10/Nov/2015:09:45:08 +0000] Discarding unused printer-state-changed event…
D [10/Nov/2015:09:45:08 +0000] [Job 39] prnt/hpcups/HPCupsFilter.cpp 565: cupsRasterOpen failed, fd = 0
D [10/Nov/2015:09:45:08 +0000] PID 22758 (/usr/lib/cups/filter/gstoraster) exited with no errors.
D [10/Nov/2015:09:45:08 +0000] [Job 39] prnt/backend/hp.c 919: ERROR: null print job total=0
D [10/Nov/2015:09:45:08 +0000] PID 22759 (/usr/lib/cups/filter/hpcups) stopped with status 1.
D [10/Nov/2015:09:45:08 +0000] PID 22760 (/usr/lib/cups/backend/hp) exited with no errors.
D [10/Nov/2015:09:45:08 +0000] Discarding unused job-state-changed event…
E [10/Nov/2015:09:45:08 +0000] [Job 39] Job stopped due to filter errors; please consult the error_log file for details.
D [10/Nov/2015:09:45:08 +0000] cupsdMarkDirty(----J-)
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Printing jobs and dirty files”, busy=“Printing jobs and dirty files”
D [10/Nov/2015:09:45:08 +0000] cupsdSetBusyState: newbusy=“Printing jobs and dirty files”, busy=“Printing jobs and dirty files”
D [10/Nov/2015:09:45:08 +0000] Discarding unused printer-state-changed event…
D [10/Nov/2015:09:45:09 +0000] [Job 39] Unloading…
D [10/Nov/2015:09:45:11 +0000] cupsdAcceptClient: 15 from localhost (Domain)
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Printing jobs and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:45:11 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:45:11 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [10/Nov/2015:09:45:11 +0000] CUPS-Get-Default
D [10/Nov/2015:09:45:11 +0000] CUPS-Get-Default client-error-not-found: No default printer.
D [10/Nov/2015:09:45:11 +0000] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:11 +0000] cupsdAcceptClient: 16 from localhost (Domain)
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 16 WAITING Closing on EOF
D [10/Nov/2015:09:45:11 +0000] cupsdCloseClient: 16
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Classes 1
D [10/Nov/2015:09:45:11 +0000] CUPS-Get-Classes
D [10/Nov/2015:09:45:11 +0000] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:45:11 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:45:11 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:45:11 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:45:11 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [10/Nov/2015:09:45:11 +0000] CUPS-Get-Printers
D [10/Nov/2015:09:45:11 +0000] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 POST / HTTP/1.1
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Active clients and dirty files”, busy=“Dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdAuthorize: No authentication data provided.
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 1.1 Get-Jobs 1
D [10/Nov/2015:09:45:11 +0000] Get-Jobs ipp://localhost/
D [10/Nov/2015:09:45:11 +0000] [Job 39] Loading attributes…
D [10/Nov/2015:09:45:11 +0000] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Active clients and dirty files”
D [10/Nov/2015:09:45:11 +0000] cupsdReadClient: 15 WAITING Closing on EOF
D [10/Nov/2015:09:45:11 +0000] cupsdCloseClient: 15
D [10/Nov/2015:09:45:11 +0000] cupsdSetBusyState: newbusy=“Dirty files”, busy=“Dirty files”
I [10/Nov/2015:09:45:39 +0000] Saving job.cache…
D [10/Nov/2015:09:45:40 +0000] cupsdSetBusyState: newbusy=“Not busy”, busy=“Dirty files”
Please find the response from CUPS administrators below:
As far as I see this has nothing to do with CUPS.
As far as I see the first error message comes from Ghostscript:
“Unable to open the initial device, quitting”
(this is in Ghostscript’s gs_init.ps file).
Therefore Ghostscript does not produce any output which
lets then the filter from HP’s HPLIP driver software
error out with “cupsRasterOpen failed” and finally
the HP backend errors out with “ERROR: null print job”.
Neither Ghostscript nor HP’s HPLIP driver software
belong to CUPS so that the issue does not belong to CUPS
(according to my analysis).
I guess that somehow the “Ghostscript command line”
is not correct or does not work as it should.
Usually this is alos no bug in Ghostscript but
“somewhere else” where the Ghostscript command line
with all its parameters is created.
I recommed to analyze what the actual root cause is
that you report this issue at your Linux distribution.
Kindly request assistance to solve the issue