I just installed openSuse 13.1 (clean, new install, stock with initial updates only) on two machines in a network, one of which has an HP Laserjet printer attached. While I am able to print test pages and pages from LibreOffice, pages sent from Kate, Kwrite, FireFox, other applications fail to print on the machine attached to the printer (parallel:/dev/lpt1). The print window for the HP shows an grayed-out output file going to pdf. Printing works for all applications on the remote, networked machine through Samba.

I have re-installed the printer several times (and reinstalled the OS, also) and looked at logs, all to no avail. CUPS, the HP print manager, and other devices all indicate there is a connected printer.

Curiously, even though the test page printed from the CUPS, the job states "unable to open print file: No such file or directory."

Here is the printers.conf file for the local machine:

Code: Select all

# Printer configuration file for CUPS v1.5.4
# Written by cupsd on 2014-04-22 15:43
# DO NOT EDIT THIS FILE WHEN CUPSD IS RUNNING
<Printer hplaserjet4050series>
UUID urn:uuid:7a7001c5-5423-33c0-6184-baebcb549446
Info HP LaserJet 4050 Series Postscript (recommended)
MakeModel HP LaserJet 4050 Series Postscript (recommended)
DeviceURI parallel:/dev/lp1
State Idle
StateTime 1398195775
Type 8425668
Accepting Yes
Shared Yes
JobSheets none none
QuotaPeriod 0
PageLimit 0
KLimit 0
OpPolicy default
ErrorPolicy stop-printer
</Printer>


Previously, in 11.4, I was able to print from all applications through Samba.

All advice welcome. Thanks.

Hmm - the greyed out PDF selection is used when printing to PDF or Postscript files, that behaviour is therefore normal.
Does CUPS indicate what happens to the jobs which aren't printing?

Thank you. Yes, the typical error is "Unable to open print file: No such file or directory" (from CUPS jobs and /var/log/cups/error.log).

Can you please try removing the printer (after noting the driver it is configured to use) and readding the printer again?

I'm happy to try uninstalling and reinstalling the printer, but please note I have done that a number of times using a variety of interfaces. The printer was first installed during automatic configuration when the OS was installed (after reboot), then CUPS, the HP tool, an applet called system-config-printer that apparently works with CUPS, and in Yast. Same results each time for KDE applications: Unable to open print file: No such file or directory (from /var/log/cups/error.log)

I am now using the following driver: HP LaserJet 4050 Series Postscript (recommended) -- see the printers.conf file in the first post.

Please let me know if you would still like me to reinstall the printer. Thanks.

Out of curiosity, I deleted and reinstalled the printer through CUPS [driver: HP LaserJet 4050 Series Postscript (recommended) ]. The default in CUPS places it on the wrong port (lp0 instead of lp1). I corrected the port designation, printed a test page and a page from LibreOffice, but cannot print from KATE:

hp4050-43 Unknown Withheld 1k 1 completed at
Sat 26 Apr 2014 11:17:31 AM EDT
"Unable to open print file: No such file or directory"

Even though I have been using SuSE linux heavily for the past ten years and frequently tinker with settings and config files, I am no expert and have a superficial understanding of printing and CUPS. Moreover, my experience with printing and CUPS has been through a network, which apparently is less finicky that printing to a local printer. I have begun to look at materials on the cups.org and openprinting.org websites, but nothing I have seen appears to offer a solution.

Even though the two machines have essentially identical stock builds, somewhere a dependency may be missing or broken, or perhaps a configuration file requires modification. I have a thread going in SuSE forums on this subject and have searched extensively, but this remains a mystery. One issue may be the parallel port, but CUPS and the system recognize the printer, so the parallel port may not be an issue.

I am still open to suggestions.

Would a change of permissions in cupsd.conf provide a remedy? If so, how?

My current cupsd.conf:

Code: Select all

# Show general information in error_log.
LogLevel warn
SystemGroup sys root
Listen *:631
Listen localhost:631
Listen /var/run/cups/cups.sock
Browsing On
BrowseOrder allow,deny
BrowseAllow all
BrowseLocalProtocols CUPS
DefaultAuthType Basic
WebInterface Yes
<Location />
  Allow @LOCAL
  Order allow,deny
  Allow 127.0.0.2
</Location>
<Location /admin>
  Order allow,deny
</Location>
<Location /admin/conf>
  AuthType Default
  Require user @SYSTEM
  Order allow,deny
</Location>
<Policy default>
  JobPrivateAccess default
  JobPrivateValues default
  SubscriptionPrivateAccess default
  SubscriptionPrivateValues default
  <Limit Create-Job Print-Job Print-URI Validate-Job>
    Order deny,allow
  </Limit>
  <Limit Send-Document Send-URI Hold-Job Release-Job Restart-Job Purge-Jobs Set-Job-Attributes Create-Job-Subscription Renew-Subscription Cancel-Subscription Get-Notifications Reprocess-Job Cancel-Current-Job Suspend-Current-Job Resume-Job Cancel-My-Jobs Close-Job CUPS-Move-Job CUPS-Get-Document>
    Require user @OWNER @SYSTEM
    Order deny,allow
  </Limit>
  <Limit CUPS-Add-Modify-Printer CUPS-Delete-Printer CUPS-Add-Modify-Class CUPS-Delete-Class CUPS-Set-Default CUPS-Get-Devices>
    AuthType Default
    Require user @SYSTEM
    Order deny,allow
  </Limit>
  <Limit Pause-Printer Resume-Printer Enable-Printer Disable-Printer Pause-Printer-After-Current-Job Hold-New-Jobs Release-Held-New-Jobs Deactivate-Printer Activate-Printer Restart-Printer Shutdown-Printer Startup-Printer Promote-Job Schedule-Job-After Cancel-Jobs CUPS-Accept-Jobs CUPS-Reject-Jobs>
    AuthType Default
    Require user @SYSTEM
    Order deny,allow
  </Limit>
  <Limit Cancel-Job CUPS-Authenticate-Job>
    Require user @OWNER @SYSTEM
    Order deny,allow
  </Limit>
  <Limit All>
    Order deny,allow
  </Limit>
</Policy>
<Policy authenticated>
  JobPrivateAccess default
  JobPrivateValues default
  SubscriptionPrivateAccess default
  SubscriptionPrivateValues default
  <Limit Create-Job Print-Job Print-URI Validate-Job>
    AuthType Default
    Order deny,allow
  </Limit>
  <Limit Send-Document Send-URI Hold-Job Release-Job Restart-Job Purge-Jobs Set-Job-Attributes Create-Job-Subscription Renew-Subscription Cancel-Subscription Get-Notifications Reprocess-Job Cancel-Current-Job Suspend-Current-Job Resume-Job Cancel-My-Jobs Close-Job CUPS-Move-Job CUPS-Get-Document>
    AuthType Default
    Require user @OWNER @SYSTEM
    Order deny,allow
  </Limit>
  <Limit CUPS-Add-Modify-Printer CUPS-Delete-Printer CUPS-Add-Modify-Class CUPS-Delete-Class CUPS-Set-Default>
    AuthType Default
    Require user @SYSTEM
    Order deny,allow
  </Limit>
  <Limit Pause-Printer Resume-Printer Enable-Printer Disable-Printer Pause-Printer-After-Current-Job Hold-New-Jobs Release-Held-New-Jobs Deactivate-Printer Activate-Printer Restart-Printer Shutdown-Printer Startup-Printer Promote-Job Schedule-Job-After Cancel-Jobs CUPS-Accept-Jobs CUPS-Reject-Jobs>
    AuthType Default
    Require user @SYSTEM
    Order deny,allow
  </Limit>
  <Limit Cancel-Job CUPS-Authenticate-Job>
    AuthType Default
    Require user @OWNER @SYSTEM
    Order deny,allow
  </Limit>
  <Limit All>
    Order deny,allow
  </Limit>
</Policy>
<Policy allowallforanybody>
  <Limit All>
    Order deny,allow
    Allow from all
  </Limit>
</Policy>
DefaultPolicy default
JobPrivateAccess default
JobPrivateValues default
MaxLogSize 2000000
SubscriptionPrivateAccess default
SubscriptionPrivateValues default


Please try increasing the LogLevel to Debug, then restart CUPS and tail the log while attempting to print from Kate, and then another application.
When posting the logs, please include separate ones for each application so the failures can be distinguished.

I can now print from Firefox! But not KATE or a terminal (bash Konsole).
Here is end of the log for an attempt to print from the terminal:

Code: Select all

D [27/Apr/2014:13:56:27 -0400] CUPS-Get-Default                                               
D [27/Apr/2014:13:56:27 -0400] CUPS-Get-Default client-error-not-found: No default printer.   
D [27/Apr/2014:13:56:27 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [27/Apr/2014:13:56:27 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [27/Apr/2014:13:56:27 -0400] cupsdReadClient: 17 WAITING Closing on EOF
D [27/Apr/2014:13:56:27 -0400] cupsdCloseClient: 17
D [27/Apr/2014:13:56:27 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [27/Apr/2014:13:59:49 -0400] Closing client 13 after 300 seconds of inactivity...
D [27/Apr/2014:13:59:49 -0400] cupsdCloseClient: 13
D [27/Apr/2014:13:59:49 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [27/Apr/2014:13:59:49 -0400] Report: clients=2
D [27/Apr/2014:13:59:49 -0400] Report: jobs=5
D [27/Apr/2014:13:59:49 -0400] Report: jobs-active=0
D [27/Apr/2014:13:59:49 -0400] Report: printers=1
D [27/Apr/2014:13:59:49 -0400] Report: printers-implicit=0
D [27/Apr/2014:13:59:49 -0400] Report: stringpool-string-count=5053
D [27/Apr/2014:13:59:49 -0400] Report: stringpool-alloc-bytes=8872
D [27/Apr/2014:13:59:49 -0400] Report: stringpool-total-bytes=91648
D [27/Apr/2014:14:00:10 -0400] Closing client 15 after 300 seconds of inactivity...
D [27/Apr/2014:14:00:10 -0400] cupsdCloseClient: 15
D [27/Apr/2014:14:00:10 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [27/Apr/2014:14:00:50 -0400] Closing client 16 after 300 seconds of inactivity...
D [27/Apr/2014:14:00:50 -0400] cupsdCloseClient: 16
D [27/Apr/2014:14:00:50 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [27/Apr/2014:14:00:50 -0400] Report: clients=0
D [27/Apr/2014:14:00:50 -0400] Report: jobs=5
D [27/Apr/2014:14:00:50 -0400] Report: jobs-active=0
D [27/Apr/2014:14:00:50 -0400] Report: printers=1
D [27/Apr/2014:14:00:50 -0400] Report: printers-implicit=0
D [27/Apr/2014:14:00:50 -0400] Report: stringpool-string-count=5053
D [27/Apr/2014:14:00:50 -0400] Report: stringpool-alloc-bytes=8872
D [27/Apr/2014:14:00:50 -0400] Report: stringpool-total-bytes=91648

Here is the log from a print attempt from KATE:

Code: Select all

D [27/Apr/2014:14:07:19 -0400] cupsdMarkDirty(----J-)
D [27/Apr/2014:14:07:19 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [27/Apr/2014:14:07:19 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [27/Apr/2014:14:07:19 -0400] Discarding unused printer-state-changed event...
D [27/Apr/2014:14:07:20 -0400] [Job 6] Unloading...
linux-5:~ # tail -70 /var/log/cups/error_log
D [27/Apr/2014:14:07:19 -0400] [Job 6] Started filter pstops (PID 5110)
D [27/Apr/2014:14:07:19 -0400] [Job 6] Page = 612x792; 12,12 to 600,780
D [27/Apr/2014:14:07:19 -0400] [Job 6] slow_collate=0, slow_duplex=0, slow_order=0
D [27/Apr/2014:14:07:19 -0400] [Job 6] Before copy_comments - %!PS-Adobe-3.0
D [27/Apr/2014:14:07:19 -0400] [Job 6] %!PS-Adobe-3.0
D [27/Apr/2014:14:07:19 -0400] [Job 6] %Produced by poppler pdftops version: 0.24.3 (http://poppler.freedesktop.org)
D [27/Apr/2014:14:07:19 -0400] [Job 6] %%Creator:
D [27/Apr/2014:14:07:19 -0400] [Job 6] %%LanguageLevel: 2
D [27/Apr/2014:14:07:19 -0400] [Job 6] %%DocumentSuppliedResources: (atend)
D [27/Apr/2014:14:07:19 -0400] [Job 6] %%DocumentMedia: 612x792 612 792 0 () ()
D [27/Apr/2014:14:07:19 -0400] [Job 6] %%BoundingBox: 0 0 612 792
D [27/Apr/2014:14:07:19 -0400] [Job 6] %%Pages: 1
D [27/Apr/2014:14:07:19 -0400] [Job 6] %%EndComments
D [27/Apr/2014:14:07:19 -0400] [Job 6] Before copy_prolog - %%BeginProlog
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Before copy_setup - %%BeginSetup
D [27/Apr/2014:14:07:19 -0400] [Job 6] Before page loop - %%Page: 1 1
D [27/Apr/2014:14:07:19 -0400] [Job 6] Copying page 1...
D [27/Apr/2014:14:07:19 -0400] [Job 6] PAGE: 1 1
D [27/Apr/2014:14:07:19 -0400] Discarding unused job-progress event...
D [27/Apr/2014:14:07:19 -0400] [Job 6] pagew = 587.5, pagel = 768.0
D [27/Apr/2014:14:07:19 -0400] [Job 6] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [27/Apr/2014:14:07:19 -0400] [Job 6] PageLeft = 12.2, PageRight = 599.8
D [27/Apr/2014:14:07:19 -0400] [Job 6] PageTop = 780.1, PageBottom = 12.1
D [27/Apr/2014:14:07:19 -0400] [Job 6] PageWidth = 612.0, PageLength = 792.0
D [27/Apr/2014:14:07:19 -0400] [Job 6] PID 5109 (pdftops) exited with no errors.
D [27/Apr/2014:14:07:19 -0400] [Job 6] STATE: -media-empty-warning
D [27/Apr/2014:14:07:19 -0400] [Job 6] STATE: -offline-report
I [27/Apr/2014:14:07:19 -0400] [Job 6] Printer is now connected.
D [27/Apr/2014:14:07:19 -0400] [Job 6] Set job-printer-state-message to "Printer is now connected.", current level=INFO
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] Discarding unused job-progress event...
D [27/Apr/2014:14:07:19 -0400] Discarding unused printer-state-changed event...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 1 pages...
D [27/Apr/2014:14:07:19 -0400] [Job 6] PID 5110 (pstops) exited with no errors.
D [27/Apr/2014:14:07:19 -0400] PID 5107 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 8192 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Read 4688 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] [Job 6] Wrote 4688 bytes of print data...
D [27/Apr/2014:14:07:19 -0400] PID 5108 (/usr/lib/cups/backend/parallel) exited with no errors.
D [27/Apr/2014:14:07:19 -0400] Discarding unused job-completed event...
I [27/Apr/2014:14:07:19 -0400] [Job 6] Job completed.
D [27/Apr/2014:14:07:19 -0400] cupsdMarkDirty(----J-)
D [27/Apr/2014:14:07:19 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [27/Apr/2014:14:07:19 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [27/Apr/2014:14:07:19 -0400] Discarding unused printer-state-changed event...
D [27/Apr/2014:14:07:20 -0400] [Job 6] Unloading...

These are obviously quite different. Please note that for a variety of reasons, I did a fresh, new install of Suse this morning.

Thanks for your time and assistance.

As far as I can tell, the printing attempt with Kate was completely successful. I'm assuming it is still not working?
If the terminal lost some of the output, could you try setting the scrollback to unlimited in the Konsole settings - then reperforming the tail and print process?

I set the scrolling in Konsole to unlimited. I am still unable to print from KATE (log tail below).

Here is the tail with 100 lines from the Konsole print attempt:

Code: Select all

linux-5:~ # /usr/lib/cups/backend/hp
direct hp "Unknown" "HP Printer (HPLIP)"
linux-5:~ # tail -100 /var/log/cups/error_log
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[20]="PPD=/etc/cups/ppd/hplaserjet4050series.ppd"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[21]="RIP_MAX_CACHE=128m"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[22]="CONTENT_TYPE=application/pdf"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[23]="DEVICE_URI=parallel:/dev/lp1"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[24]="PRINTER_INFO=HP LaserJet 4050 Series Postscript (recommended)"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[25]="PRINTER_LOCATION="
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[26]="PRINTER=hplaserjet4050series"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[27]="PRINTER_STATE_REASONS=none"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[28]="CUPS_FILETYPE=document"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [28/Apr/2014:10:42:01 -0400] [Job 10] envp[30]="AUTH_I****"
I [28/Apr/2014:10:42:01 -0400] [Job 10] Started filter /usr/lib/cups/filter/pdftops (PID 4208)
I [28/Apr/2014:10:42:01 -0400] [Job 10] Started backend /usr/lib/cups/backend/parallel (PID 4209)
D [28/Apr/2014:10:42:01 -0400] Discarding unused job-state-changed event...
D [28/Apr/2014:10:42:01 -0400] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/hplaserjet4050series) from localhost
D [28/Apr/2014:10:42:01 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [28/Apr/2014:10:42:01 -0400] [Job 10] STATE: +connecting-to-device
D [28/Apr/2014:10:42:01 -0400] Discarding unused printer-state-changed event...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Started filter pdftops (PID 4212)
D [28/Apr/2014:10:42:01 -0400] [Job 10] Started filter pstops (PID 4213)
D [28/Apr/2014:10:42:01 -0400] [Job 10] STATE: -connecting-to-device
D [28/Apr/2014:10:42:01 -0400] Discarding unused printer-state-changed event...
D [28/Apr/2014:10:42:01 -0400] [Job 10] backendRunLoop(print_fd=0, device_fd=5, snmp_fd=-1, addr=(nil), use_bc=0, side_cb=0x7f74be2e6130)
D [28/Apr/2014:10:42:01 -0400] [Job 10] Page = 612x792; 12,12 to 600,780
D [28/Apr/2014:10:42:01 -0400] [Job 10] slow_collate=0, slow_duplex=0, slow_order=0
D [28/Apr/2014:10:42:01 -0400] [Job 10] Before copy_comments - %!PS-Adobe-3.0
D [28/Apr/2014:10:42:01 -0400] [Job 10] %!PS-Adobe-3.0
D [28/Apr/2014:10:42:01 -0400] [Job 10] %Produced by poppler pdftops version: 0.24.3 (http://poppler.freedesktop.org)
D [28/Apr/2014:10:42:01 -0400] [Job 10] %%Creator:
D [28/Apr/2014:10:42:01 -0400] [Job 10] %%LanguageLevel: 2
D [28/Apr/2014:10:42:01 -0400] [Job 10] %%DocumentSuppliedResources: (atend)
D [28/Apr/2014:10:42:01 -0400] [Job 10] %%DocumentMedia: 612x792 612 792 0 () ()
D [28/Apr/2014:10:42:01 -0400] [Job 10] %%BoundingBox: 0 0 612 792
D [28/Apr/2014:10:42:01 -0400] [Job 10] %%Pages: 1
D [28/Apr/2014:10:42:01 -0400] [Job 10] %%EndComments
D [28/Apr/2014:10:42:01 -0400] [Job 10] Before copy_prolog - %%BeginProlog
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 4096 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Before copy_setup - %%BeginSetup
D [28/Apr/2014:10:42:01 -0400] [Job 10] Before page loop - %%Page: 1 1
D [28/Apr/2014:10:42:01 -0400] [Job 10] Copying page 1...
D [28/Apr/2014:10:42:01 -0400] [Job 10] PAGE: 1 1
D [28/Apr/2014:10:42:01 -0400] Discarding unused job-progress event...
D [28/Apr/2014:10:42:01 -0400] [Job 10] pagew = 587.5, pagel = 768.0
D [28/Apr/2014:10:42:01 -0400] [Job 10] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [28/Apr/2014:10:42:01 -0400] [Job 10] PageLeft = 12.2, PageRight = 599.8
D [28/Apr/2014:10:42:01 -0400] [Job 10] PageTop = 780.1, PageBottom = 12.1
D [28/Apr/2014:10:42:01 -0400] [Job 10] PageWidth = 612.0, PageLength = 792.0
D [28/Apr/2014:10:42:01 -0400] [Job 10] STATE: -media-empty-warning
D [28/Apr/2014:10:42:01 -0400] [Job 10] STATE: -offline-report
I [28/Apr/2014:10:42:01 -0400] [Job 10] Printer is now connected.
D [28/Apr/2014:10:42:01 -0400] [Job 10] Set job-printer-state-message to "Printer is now connected.", current level=INFO
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 4096 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] Discarding unused job-progress event...
D [28/Apr/2014:10:42:01 -0400] Discarding unused printer-state-changed event...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] PID 4212 (pdftops) exited with no errors.
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 1 pages...
D [28/Apr/2014:10:42:01 -0400] [Job 10] PID 4213 (pstops) exited with no errors.
D [28/Apr/2014:10:42:01 -0400] PID 4208 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 8192 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Read 7860 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] [Job 10] Wrote 7860 bytes of print data...
D [28/Apr/2014:10:42:01 -0400] PID 4209 (/usr/lib/cups/backend/parallel) exited with no errors.
D [28/Apr/2014:10:42:01 -0400] Discarding unused job-completed event...
I [28/Apr/2014:10:42:01 -0400] [Job 10] Job completed.
D [28/Apr/2014:10:42:01 -0400] cupsdMarkDirty(----J-)
D [28/Apr/2014:10:42:01 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Apr/2014:10:42:01 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Apr/2014:10:42:01 -0400] Discarding unused printer-state-changed event...
D [28/Apr/2014:10:42:02 -0400] [Job 10] Unloading...
I [28/Apr/2014:10:42:33 -0400] Saving job.cache...
D [28/Apr/2014:10:42:33 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"
linux-5:~ #


Here it again with tail -f (Konsole):

Code: Select all

linux-5:~ # /usr/lib/cups/backend/hp
direct hp "Unknown" "HP Printer (HPLIP)"
linux-5:~ # /usr/lib/cups/backend/hp
direct hp "Unknown" "HP Printer (HPLIP)"
linux-5:~ # tail -f /var/log/cups/error_log
D [28/Apr/2014:10:51:26 -0400] [Job 12] Read 4253 bytes of print data...
D [28/Apr/2014:10:51:26 -0400] [Job 12] Wrote 4253 bytes of print data...
D [28/Apr/2014:10:51:26 -0400] PID 12555 (/usr/lib/cups/backend/parallel) exited with no errors.
D [28/Apr/2014:10:51:26 -0400] Discarding unused job-completed event...
I [28/Apr/2014:10:51:26 -0400] [Job 12] Job completed.
D [28/Apr/2014:10:51:26 -0400] cupsdMarkDirty(----J-)
D [28/Apr/2014:10:51:26 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Apr/2014:10:51:26 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Apr/2014:10:51:26 -0400] Discarding unused printer-state-changed event...
D [28/Apr/2014:10:51:27 -0400] [Job 12] Unloading...
D [28/Apr/2014:10:51:36 -0400] Closing client 15 after 300 seconds of inactivity...
D [28/Apr/2014:10:51:36 -0400] cupsdCloseClient: 15
D [28/Apr/2014:10:51:36 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [28/Apr/2014:10:51:45 -0400] Closing client 16 after 300 seconds of inactivity...
D [28/Apr/2014:10:51:45 -0400] cupsdCloseClient: 16
D [28/Apr/2014:10:51:45 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [28/Apr/2014:10:51:52 -0400] Saving job.cache...
D [28/Apr/2014:10:51:53 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"


From a print attempt on KATE:

Code: Select all

linux-5:~ # tail -f /var/log/cups/error_log
D [28/Apr/2014:10:53:59 -0400] cupsdMarkDirty(----J-)
D [28/Apr/2014:10:53:59 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Apr/2014:10:53:59 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Apr/2014:10:53:59 -0400] Discarding unused printer-state-changed event...
D [28/Apr/2014:10:54:00 -0400] [Job 13] Unloading...
D [28/Apr/2014:10:54:29 -0400] cupsdReadClient: 13 WAITING Closing on EOF
D [28/Apr/2014:10:54:29 -0400] cupsdCloseClient: 13
D [28/Apr/2014:10:54:29 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
I [28/Apr/2014:10:54:29 -0400] Saving job.cache...
D [28/Apr/2014:10:54:30 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" 


Instead of error_log can you try tailing page_log instead please?

Thanks for your continuing efforts.

Here are tails for both the page and error logs for KATE and Konsole:

Code: Select all

From activity on KATE:

page_log:

linux-5:~ # tail -f /var/log/cups/page_log
hplaserjet4050series root 5 [27/Apr/2014:13:55:49 -0400] 1 1 - localhost  Letter -
hplaserjet4050series root 6 [27/Apr/2014:14:07:19 -0400] 1 1 - localhost Untitled Letter -
hplaserjet4050series root 7 [27/Apr/2014:14:15:37 -0400] 1 1 - localhost Linux Commando: Log watching using tail or less - -
hplaserjet4050series root 8 [27/Apr/2014:14:16:04 -0400] 1 1 - localhost Google Scholar - -
hplaserjet4050series root 9 [27/Apr/2014:14:16:21 -0400] 1 1 - localhost Linux Commando: Log watching using tail or less - -
hplaserjet4050series root 10 [28/Apr/2014:10:42:01 -0400] 1 1 - localhost  Letter -
hplaserjet4050series root 11 [28/Apr/2014:10:46:44 -0400] 1 1 - localhost Attached printer not working in openSuse 13.1 • KDE Community Forums - -
hplaserjet4050series root 12 [28/Apr/2014:10:51:21 -0400] 1 1 - localhost  Letter -
hplaserjet4050series root 13 [28/Apr/2014:10:53:59 -0400] 1 1 - localhost Untitled Letter -
hplaserjet4050series root 14 [29/Apr/2014:08:19:11 -0400] 1 1 - localhost Untitled Letter -

error_log:

linux-5:~ # tail -f /var/log/cups/error_log
D [29/Apr/2014:08:19:11 -0400] PID 4054 (/usr/lib/cups/backend/parallel) exited with no errors.
D [29/Apr/2014:08:19:11 -0400] Discarding unused job-completed event...
I [29/Apr/2014:08:19:11 -0400] [Job 14] Job completed.
D [29/Apr/2014:08:19:11 -0400] cupsdMarkDirty(----J-)
D [29/Apr/2014:08:19:11 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [29/Apr/2014:08:19:11 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [29/Apr/2014:08:19:11 -0400] Discarding unused printer-state-changed event...
D [29/Apr/2014:08:19:12 -0400] [Job 14] Unloading...
I [29/Apr/2014:08:19:42 -0400] Saving job.cache...
D [29/Apr/2014:08:19:43 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"


From activity on Konsole/terminal:

page_log:

linux-5:~ # tail -f /var/log/cups/page_log
hplaserjet4050series root 6 [27/Apr/2014:14:07:19 -0400] 1 1 - localhost Untitled Letter -
hplaserjet4050series root 7 [27/Apr/2014:14:15:37 -0400] 1 1 - localhost Linux Commando: Log watching using tail or less - -
hplaserjet4050series root 8 [27/Apr/2014:14:16:04 -0400] 1 1 - localhost Google Scholar - -
hplaserjet4050series root 9 [27/Apr/2014:14:16:21 -0400] 1 1 - localhost Linux Commando: Log watching using tail or less - -
hplaserjet4050series root 10 [28/Apr/2014:10:42:01 -0400] 1 1 - localhost  Letter -
hplaserjet4050series root 11 [28/Apr/2014:10:46:44 -0400] 1 1 - localhost Attached printer not working in openSuse 13.1 • KDE Community Forums - -
hplaserjet4050series root 12 [28/Apr/2014:10:51:21 -0400] 1 1 - localhost  Letter -
hplaserjet4050series root 13 [28/Apr/2014:10:53:59 -0400] 1 1 - localhost Untitled Letter -
hplaserjet4050series root 14 [29/Apr/2014:08:19:11 -0400] 1 1 - localhost Untitled Letter -
hplaserjet4050series root 15 [29/Apr/2014:08:25:12 -0400] 1 1 - localhost  Letter -

error_log:

linux-5:~ # tail -f /var/log/cups/error_log
D [29/Apr/2014:08:25:18 -0400] PID 4162 (/usr/lib/cups/backend/parallel) exited with no errors.
D [29/Apr/2014:08:25:18 -0400] Discarding unused job-completed event...
I [29/Apr/2014:08:25:18 -0400] [Job 15] Job completed.
D [29/Apr/2014:08:25:18 -0400] cupsdMarkDirty(----J-)
D [29/Apr/2014:08:25:18 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [29/Apr/2014:08:25:18 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [29/Apr/2014:08:25:18 -0400] Discarding unused printer-state-changed event...
D [29/Apr/2014:08:25:19 -0400] [Job 15] Unloading...
I [29/Apr/2014:08:25:43 -0400] Saving job.cache...
D [29/Apr/2014:08:25:43 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"
D [29/Apr/2014:08:30:13 -0400] Closing client 13 after 300 seconds of inactivity...
D [29/Apr/2014:08:30:13 -0400] cupsdCloseClient: 13
D [29/Apr/2014:08:30:13 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [29/Apr/2014:08:30:13 -0400] Report: clients=0
D [29/Apr/2014:08:30:13 -0400] Report: jobs=15
D [29/Apr/2014:08:30:13 -0400] Report: jobs-active=0
D [29/Apr/2014:08:30:13 -0400] Report: printers=1
D [29/Apr/2014:08:30:13 -0400] Report: printers-implicit=0
D [29/Apr/2014:08:30:13 -0400] Report: stringpool-string-count=5073
D [29/Apr/2014:08:30:13 -0400] Report: stringpool-alloc-bytes=8872
D [29/Apr/2014:08:30:13 -0400] Report: stringpool-total-bytes=91968


Please let me know if this is not what you were seeking. Thanks.

Hmm - are you initiating the tail before, or immediately after you hit the print button?
Based on the posted logs, it seems that a whole portion is missing - Job 15 is completed a few lines into the log...

Code: Select all

I [29/Apr/2014:08:25:18 -0400] [Job 15] Job completed.