[Pkg-cups-devel] Bug#504278: HP USB LaserJet printer disabled on first attempt to print

Daniel Pocock daniel at pocock.com.au
Tue Nov 4 21:00:18 UTC 2008



Roger Leigh wrote:
> On Tue, Nov 04, 2008 at 06:36:11PM +0000, Daniel Pocock wrote:
>   
>>> Just set error policy = retry-job (rather than stop-printer) in the printer
>>> options for your printer.  It will then keep retrying until the problem
>>> goes away.  Obviously there's also a problem which causes the queue to
>>> be disabled (e.g. printer switched off or out of paper), which you might
>>> need to look at separately.
>>>   
>>>       
>> I've tried that - it still insists on an administrator login to the web  
>> interface to re-enable the printer.
>>     
>
> It shouldn't require that, unless there was a more serious problem.
>
>   
>> I notice that I can use xsane with the same USB device (it is a  
>> multi-function) immediately after starting the computer.  It is only  
>> when I want to print that I get problems.  That makes me suspect that  
>> the low level USB modules are not at fault.
>>     
>
> Try running "lsusb" immediately after starting.  Both the scanner
> and printer should show up as separate devices (they are in fact entirely
> logically separate devices inside a single box, so a fault with the printer
> part will mean the scanner will still function perfectly).
>
>   
# lsusb
Bus 005 Device 006: ID 04b4:00ff Cypress Semiconductor Corp.
Bus 005 Device 005: ID 0aec:3260 Neodio Technologies Corp. 7-in-1 Card 
Reader
Bus 005 Device 004: ID 03f0:3417 Hewlett-Packard LaserJet 3055
Bus 005 Device 003: ID 0424:2504 Standard Microsystems Corp. USB 2.0 Hub
Bus 005 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 002 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 001 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub



>> Can you suggest any other troubleshooting commands that should be run,  
>> either by myself or anyone else who stumbles across this bug report?  I  
>> realise there is a possibility that cups is not the culprit (maybe it is  
>> the kernel module or something in the hplip package), but I'm not sure  
>> how to pin down the root cause.
>>     
>
> In cupsd.conf, set LogLevel=debug, and then restart cups
> (/etc/init.d/cups restart).  You will now get much more detailed logs in
> /var/log/cups/error_log.  If you now try printing, the exact cause of the
> error should be logged to this file.  If you're not sure about how to
> interpret the log, attach it to your reply to this mail (from after you
> restart).
>
>
>   

I've done that, below is the content of syslog and cups/error_log from 
the moment when I tried to print.

I also checked lsusb a second time after trying to print, the output 
hasn't changed.

Does anything here suggest the cause of the fault?


Nov  4 20:54:52 srv1 kernel: [11671.260732] usblp0: removed
Nov  4 20:54:53 srv1 hal_lpadmin: remove
Nov  4 20:54:53 srv1 hal_lpadmin: Found configured printer: HP_LaserJet_3055
Nov  4 20:54:53 srv1 python: hp-makeuri[4647]: warning: hp-makeuri 
should not be run as root.
Nov  4 20:54:53 srv1 python: hp-makeuri[4651]: warning: hp-makeuri 
should not be run as root.
Nov  4 20:54:53 srv1 hal_lpadmin: Disabled printer HP_LaserJet_3055, as 
the corresponding device was unplugged or turned off
Nov  4 20:54:53 srv1 hal_lpadmin: Found configured printer: 
HP_LaserJet_3055_fax





D [04/Nov/2008:20:54:47 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Printers
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Classes
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Default
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Default client-error-not-found: 
No default printer
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 9 status_code=406 
(client-error-not-found)
D [04/Nov/2008:20:54:47 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:47 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Printers
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Classes
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Default
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Default client-error-not-found: 
No default printer
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 9 status_code=406 
(client-error-not-found)
D [04/Nov/2008:20:54:47 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:47 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Default
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Default client-error-not-found: 
No default printer
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 9 status_code=406 
(client-error-not-found)
D [04/Nov/2008:20:54:47 +0000] cupsdAcceptClient: 11 from localhost (Domain)
D [04/Nov/2008:20:54:47 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:47 +0000] cupsdReadClient: 11 POST / HTTP/1.1
D [04/Nov/2008:20:54:47 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:47 +0000] CUPS-Get-Printers
D [04/Nov/2008:20:54:47 +0000] cupsdProcessIPPRequest: 11 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:48 +0000] cupsdAcceptClient: 9 from localhost:631 
(IPv4)
D [04/Nov/2008:20:54:48 +0000] cupsdCloseClient: 11
D [04/Nov/2008:20:54:48 +0000] cupsdReadClient: 9 GET 
/printers/HP_LaserJet_3055.ppd HTTP/1.1
D [04/Nov/2008:20:54:48 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:48 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:52 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST /printers/cl0 
HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] Print-Job ipp://localhost:631/printers/cl0
D [04/Nov/2008:20:54:52 +0000] [Job ???] Auto-typing file...
I [04/Nov/2008:20:54:52 +0000] [Job ???] Request file type is 
application/postscript.
D [04/Nov/2008:20:54:52 +0000] add_job: requesting-user-name="daniel"
I [04/Nov/2008:20:54:52 +0000] [Job 106] Adding start banner page "none".
D [04/Nov/2008:20:54:52 +0000] Discarding unused job-created event...
I [04/Nov/2008:20:54:52 +0000] [Job 106] Adding end banner page "none".
I [04/Nov/2008:20:54:52 +0000] [Job 106] File of type 
application/postscript queued by "daniel".
D [04/Nov/2008:20:54:52 +0000] [Job 106] hold_until=0
D [04/Nov/2008:20:54:52 +0000] Discarding unused printer-state-changed 
event...
D [04/Nov/2008:20:54:52 +0000] [Job 106] job-sheets=none,none
D [04/Nov/2008:20:54:52 +0000] [Job 106] banner_page = 0
D [04/Nov/2008:20:54:52 +0000] [Job 106] argv[0]="HP_LaserJet_3055"
D [04/Nov/2008:20:54:52 +0000] [Job 106] argv[1]="106"
D [04/Nov/2008:20:54:52 +0000] [Job 106] argv[2]="daniel"
D [04/Nov/2008:20:54:52 +0000] [Job 106] argv[3]="Home Page"
D [04/Nov/2008:20:54:52 +0000] [Job 106] argv[4]="1"
D [04/Nov/2008:20:54:52 +0000] [Job 106] argv[5]="PrintoutMode=Normal 
PageSize=Letter Quality=FromPrintoutMode Duplex=None InputSlot=Default 
number-up=1 job-uuid=urn:uuid:24c11272-0bf3-3431-6a0d-1b631efd89ab"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
argv[6]="/var/spool/cups/d00106-001"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[1]="CUPS_DATADIR=/usr/share/cups"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[7]="CUPS_STATEDIR=/var/run/cups"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[9]="SERVER_ADMIN=root at srv1.trendhosting.net"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[10]="SOFTWARE=CUPS/1.3.8"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[11]="TMPDIR=/var/spool/cups/tmp"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[12]="TZ=Europe/London"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[13]="USER=root"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[15]="CUPS_ENCRYPTION=IfRequested"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[16]="IPP_PORT=631"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[17]="CHARSET=utf-8"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[18]="LANG=en_GB.UTF8"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[19]="PPD=/etc/cups/ppd/HP_LaserJet_3055.ppd"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[20]="RIP_MAX_CACHE=8m"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[21]="CONTENT_TYPE=application/postscript"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[22]="DEVICE_URI=hp:/usb/HP_LaserJet_3055?serial=00CNSKL85143"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[23]="PRINTER=HP_LaserJet_3055"
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
envp[24]="FINAL_CONTENT_TYPE=printer/HP_LaserJet_3055"
D [04/Nov/2008:20:54:52 +0000] [Job 106] envp[25]="CLASS=cl0"
I [04/Nov/2008:20:54:52 +0000] [Job 106] Started filter 
/usr/lib/cups/filter/pstops (PID 4615)
I [04/Nov/2008:20:54:52 +0000] [Job 106] Started filter 
/usr/lib/cups/filter/foomatic-rip (PID 4616)
I [04/Nov/2008:20:54:52 +0000] [Job 106] Started backend 
/usr/lib/cups/backend/hp (PID 4617)
D [04/Nov/2008:20:54:52 +0000] Discarding unused job-state-changed event...
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:52 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:52 +0000] Discarding unused printer-state-changed 
event...
D [04/Nov/2008:20:54:52 +0000] [Job 106] Page = 612x792; 18,14 to 594,778
D [04/Nov/2008:20:54:52 +0000] [Job 106] slow_collate=0, slow_duplex=0, 
slow_order=0
D [04/Nov/2008:20:54:52 +0000] [Job 106] Before copy_comments - 
%!PS-Adobe-3.0
D [04/Nov/2008:20:54:52 +0000] [Job 106] %!PS-Adobe-3.0
D [04/Nov/2008:20:54:52 +0000] [Job 106] %%Creator: cairo 1.6.4 
(http://cairographics.org)
D [04/Nov/2008:20:54:52 +0000] [Job 106] %%CreationDate: Tue Nov  4 
20:54:52 2008
D [04/Nov/2008:20:54:52 +0000] [Job 106] %%Pages: 2
D [04/Nov/2008:20:54:52 +0000] [Job 106] %%BoundingBox: 0 0 612 792
D [04/Nov/2008:20:54:52 +0000] [Job 106] %%DocumentData: Clean7Bit
D [04/Nov/2008:20:54:52 +0000] [Job 106] %%LanguageLevel: 2
D [04/Nov/2008:20:54:52 +0000] [Job 106] %%EndComments
D [04/Nov/2008:20:54:52 +0000] [Job 106] Before copy_prolog - %%BeginProlog
D [04/Nov/2008:20:54:52 +0000] [Job 106] Before copy_setup - 11 dict begin
D [04/Nov/2008:20:54:52 +0000] [Job 106] Before page loop - %%Page: 1 1
D [04/Nov/2008:20:54:52 +0000] [Job 106] Copying page 1...
D [04/Nov/2008:20:54:52 +0000] [Job 106] pagew = 576.0, pagel = 763.2
D [04/Nov/2008:20:54:52 +0000] [Job 106] bboxx = 0, bboxy = 0, bboxw = 
612, bboxl = 792
D [04/Nov/2008:20:54:52 +0000] [Job 106] PageLeft = 18.0, PageRight = 594.0
D [04/Nov/2008:20:54:52 +0000] [Job 106] PageTop = 777.6, PageBottom = 14.4
D [04/Nov/2008:20:54:52 +0000] [Job 106] PageWidth = 612.0, PageLength = 
792.0
D [04/Nov/2008:20:54:52 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] Get-Jobs ipp://localhost/jobs/
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:52 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:52 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] Create-Printer-Subscription /
D [04/Nov/2008:20:54:52 +0000] cupsdCreateSubscription(con=0x1ff5250(9), 
uri="/")
D [04/Nov/2008:20:54:52 +0000] pullmethod="ippget"
D [04/Nov/2008:20:54:52 +0000] notify-lease-duration=86400
D [04/Nov/2008:20:54:52 +0000] notify-time-interval=0
D [04/Nov/2008:20:54:52 +0000] cupsdAddSubscription(mask=1798f, 
dest=(nil)(), job=(nil)(0), uri="(null)")
D [04/Nov/2008:20:54:52 +0000] Added subscription 53 for server
I [04/Nov/2008:20:54:52 +0000] Saving subscriptions.conf...
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] Get-Jobs ipp://localhost/jobs/
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] CUPS-Get-Printers
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] CUPS-Get-Printers
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] CUPS-Get-Classes
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:52 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:52 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:52 +0000] CUPS-Get-Default
D [04/Nov/2008:20:54:52 +0000] CUPS-Get-Default client-error-not-found: 
No default printer
D [04/Nov/2008:20:54:52 +0000] cupsdProcessIPPRequest: 9 status_code=406 
(client-error-not-found)
D [04/Nov/2008:20:54:52 +0000] cupsdAcceptClient: 12 from localhost (Domain)
D [04/Nov/2008:20:54:52 +0000] cupsdCloseClient: 12
D [04/Nov/2008:20:54:52 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:52 +0000] [Job 106] foomatic-rip version $Revision$ 
running...
D [04/Nov/2008:20:54:52 +0000] [Job 106] Parsing PPD file ...
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option ColorSpace
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option PageSize
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option Model
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option PrintoutMode
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option InputSlot
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option Duplex
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option Quality
D [04/Nov/2008:20:54:52 +0000] [Job 106] *cupsFilter: 
"application/vnd.cups-postscript 0 foomatic-rip"
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option PageRegion
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option ImageableArea
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option PaperDimension
D [04/Nov/2008:20:54:52 +0000] [Job 106] Added option Font
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] Parameter Summary
D [04/Nov/2008:20:54:52 +0000] [Job 106] -----------------
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] Spooler: cups
D [04/Nov/2008:20:54:52 +0000] [Job 106] Printer: HP_LaserJet_3055
D [04/Nov/2008:20:54:52 +0000] [Job 106] Shell: /bin/sh
D [04/Nov/2008:20:54:52 +0000] [Job 106] PPD file: 
/etc/cups/ppd/HP_LaserJet_3055.ppd
D [04/Nov/2008:20:54:52 +0000] [Job 106] ATTR file:
D [04/Nov/2008:20:54:52 +0000] [Job 106] Printer model: HP LaserJet 3055 
Foomatic/hpijs, hpijs 2.8.6
D [04/Nov/2008:20:54:52 +0000] [Job 106] Job title: Home Page
D [04/Nov/2008:20:54:52 +0000] [Job 106] File(s) to be printed:
D [04/Nov/2008:20:54:52 +0000] [Job 106] <STDIN>
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] GhostScript extra search path 
('GS_LIB'): /usr/share/cups/fonts
D [04/Nov/2008:20:54:52 +0000] [Job 106] Pondering option 
'PrintoutMode=Normal'
D [04/Nov/2008:20:54:52 +0000] [Job 106] Pondering option 'PageSize=Letter'
D [04/Nov/2008:20:54:52 +0000] [Job 106] Pondering option 
'Quality=FromPrintoutMode'
D [04/Nov/2008:20:54:52 +0000] [Job 106] Pondering option 'Duplex=None'
D [04/Nov/2008:20:54:52 +0000] [Job 106] Pondering option 
'InputSlot=Default'
D [04/Nov/2008:20:54:52 +0000] [Job 106] Pondering option 'number-up=1'
D [04/Nov/2008:20:54:52 +0000] [Job 106] Unknown option number-up=1.
D [04/Nov/2008:20:54:52 +0000] [Job 106] Pondering option 
'job-uuid=urn:uuid:24c11272-0bf3-3431-6a0d-1b631efd89ab'
D [04/Nov/2008:20:54:52 +0000] [Job 106] Unknown option 
job-uuid=urn:uuid:24c11272-0bf3-3431-6a0d-1b631efd89ab.
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
================================================
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] File: <STDIN>
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] 
================================================
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] Reading PostScript input ...
D [04/Nov/2008:20:54:52 +0000] [Job 106] --> This document is 
DSC-conforming!
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] -----------
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginProlog
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%EndProlog
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] -----------
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginSetup
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginFeature: 
*PageRegion Letter
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: PageRegion=Letter --> 
Option will be set by PostScript interpreter
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %% 
FoomaticRIPOptionSetting: PageSize=Letter
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: PageSize=Letter --> 
Setting option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginFeature: 
*PrintoutMode Normal
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: PrintoutMode=Normal --> 
Setting option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %% 
FoomaticRIPOptionSetting: PrintoutMode=Normal
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: PrintoutMode=Normal --> 
Setting option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginFeature: 
*InputSlot Default
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: InputSlot=Default --> 
Setting option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %% 
FoomaticRIPOptionSetting: InputSlot=Default
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: InputSlot=Default --> 
Setting option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginFeature: *Quality 
FromPrintoutMode
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: 
Quality=FromPrintoutMode --> Setting option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %% 
FoomaticRIPOptionSetting: Quality=@PrintoutMode
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: 
Quality=FromPrintoutMode --> Setting option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginFeature: *Duplex None
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: Duplex=None --> Setting 
option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %% 
FoomaticRIPOptionSetting: Duplex=None
D [04/Nov/2008:20:54:52 +0000] [Job 106] Option: Duplex=None --> Setting 
option
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%EndSetup
D [04/Nov/2008:20:54:52 +0000] [Job 106] Inserting PostScript code for 
CUPS' page accounting
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] -----------
D [04/Nov/2008:20:54:52 +0000] [Job 106] New page:  1 1
D [04/Nov/2008:20:54:52 +0000] [Job 106] Inserting option code into 
"PageSetup" section.
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%BeginPageSetup
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: %%EndPageSetup
D [04/Nov/2008:20:54:52 +0000] [Job 106] End of page header
D [04/Nov/2008:20:54:52 +0000] [Job 106] Copying page 2...
D [04/Nov/2008:20:54:52 +0000] [Job 106] pagew = 576.0, pagel = 763.2
D [04/Nov/2008:20:54:52 +0000] [Job 106] bboxx = 0, bboxy = 0, bboxw = 
612, bboxl = 792
D [04/Nov/2008:20:54:52 +0000] [Job 106] PageLeft = 18.0, PageRight = 594.0
D [04/Nov/2008:20:54:52 +0000] [Job 106] PageTop = 777.6, PageBottom = 14.4
D [04/Nov/2008:20:54:52 +0000] [Job 106] PageWidth = 612.0, PageLength = 
792.0
D [04/Nov/2008:20:54:52 +0000] [Job 106] Stopping search for page header 
options
D [04/Nov/2008:20:54:52 +0000] [Job 106] Found: 14.037109 0 0 14.037109 
60 266.55 Tm
D [04/Nov/2008:20:54:52 +0000] [Job 106] --> Output goes directly to the 
renderer now.
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] Starting renderer
D [04/Nov/2008:20:54:52 +0000] [Job 106] Wrote 2 pages...
D [04/Nov/2008:20:54:52 +0000] PID 4615 (/usr/lib/cups/filter/pstops) 
exited with no errors.
D [04/Nov/2008:20:54:52 +0000] [Job 106] JCL: <job data>
D [04/Nov/2008:20:54:52 +0000] [Job 106]
D [04/Nov/2008:20:54:52 +0000] [Job 106] renderer PID kid4=4640
D [04/Nov/2008:20:54:52 +0000] [Job 106] renderer command: gs -q -dBATCH 
-dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs 
-dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 
-sDeviceManufacturer="HEWLETT-PACKARD" -sDeviceModel="HP LaserJet" 
-dDuplex=false -r300 
-sIjsParams=Quality:Quality=0,Quality:ColorMode=0,Quality:MediaType=0,Quality:PenSet=0,PS:MediaPosition=7 
-dIjsUseOutputFD -sOutputFile=- -
D [04/Nov/2008:20:54:53 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:53 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:53 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:53 +0000] CUPS-Get-Printers
D [04/Nov/2008:20:54:53 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:53 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:53 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:53 +0000] CUPS-Get-Classes
D [04/Nov/2008:20:54:53 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:53 +0000] cupsdAcceptClient: 12 from localhost (Domain)
D [04/Nov/2008:20:54:53 +0000] cupsdReadClient: 12 POST / HTTP/1.1
D [04/Nov/2008:20:54:53 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:53 +0000] Get-Notifications /
D [04/Nov/2008:20:54:53 +0000] cupsdIsAuthorized: 
requesting-user-name="daniel"
D [04/Nov/2008:20:54:53 +0000] cupsdProcessIPPRequest: 12 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:53 +0000] cupsdCloseClient: 12
D [04/Nov/2008:20:54:53 +0000] cupsdReadClient: 9 POST /admin/ HTTP/1.1
D [04/Nov/2008:20:54:53 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:53 +0000] Pause-Printer 
ipp://localhost/printers/HP_LaserJet_3055
D [04/Nov/2008:20:54:53 +0000] cupsdIsAuthorized: username=""
E [04/Nov/2008:20:54:53 +0000] Pause-Printer: Unauthorized
D [04/Nov/2008:20:54:53 +0000] cupsdSendError: 9 code=401 (Unauthorized)
D [04/Nov/2008:20:54:53 +0000] cupsdSendHeader: WWW-Authenticate: Basic 
realm="CUPS"
D [04/Nov/2008:20:54:53 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:53 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:53 +0000] cupsdReadClient: 9 POST /admin/ HTTP/1.1
D [04/Nov/2008:20:54:53 +0000] cupsdAuthorize: Authorized as root using 
Local
D [04/Nov/2008:20:54:53 +0000] Pause-Printer 
ipp://localhost/printers/HP_LaserJet_3055
D [04/Nov/2008:20:54:53 +0000] cupsdIsAuthorized: username="root"
I [04/Nov/2008:20:54:53 +0000] Saving subscriptions.conf...
I [04/Nov/2008:20:54:53 +0000] Saving printers.conf...
I [04/Nov/2008:20:54:53 +0000] Saving subscriptions.conf...
I [04/Nov/2008:20:54:53 +0000] Printer "HP_LaserJet_3055" stopped by "root".
D [04/Nov/2008:20:54:53 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:53 +0000] PID 4616 
(/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [04/Nov/2008:20:54:53 +0000] PID 4617 (/usr/lib/cups/backend/hp) 
exited with no errors.
D [04/Nov/2008:20:54:53 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:54 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:54 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:54 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:54 +0000] Get-Jobs ipp://localhost/jobs/
D [04/Nov/2008:20:54:54 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:54 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:54:54 +0000] cupsdAcceptClient: 9 from localhost (Domain)
D [04/Nov/2008:20:54:54 +0000] cupsdReadClient: 9 POST / HTTP/1.1
D [04/Nov/2008:20:54:54 +0000] cupsdAuthorize: No authentication data 
provided.
D [04/Nov/2008:20:54:54 +0000] Get-Notifications /
D [04/Nov/2008:20:54:54 +0000] cupsdIsAuthorized: 
requesting-user-name="daniel"
D [04/Nov/2008:20:54:54 +0000] cupsdProcessIPPRequest: 9 status_code=0 
(successful-ok)
D [04/Nov/2008:20:54:54 +0000] cupsdCloseClient: 9
D [04/Nov/2008:20:55:06 +0000] Report: clients=0
D [04/Nov/2008:20:55:06 +0000] Report: jobs=72
D [04/Nov/2008:20:55:06 +0000] Report: jobs-active=1
D [04/Nov/2008:20:55:06 +0000] Report: printers=3
D [04/Nov/2008:20:55:06 +0000] Report: printers-implicit=0
D [04/Nov/2008:20:55:06 +0000] Report: stringpool-string-count=726
D [04/Nov/2008:20:55:06 +0000] Report: stringpool-alloc-bytes=11712
D [04/Nov/2008:20:55:06 +0000] Report: stringpool-total-bytes=14280












More information about the Pkg-cups-devel mailing list