Attachment 427211 Details for Bug 688614

cups error log when printing test page with HPLIP tool, printer created with hp-toolbox, printer driver hpijs

error_log_1 (text/plain), 40.18 KB, created by Ralf Krüdewagen on 2011-04-29 05:59:55 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Ralf Krüdewagen

Created: 2011-04-29 05:59:55 UTC

Size: 40.18 KB

patch

obsolete

>I [29/Apr/2011:07:37:28 +0200] Listening to ::1:631 (IPv6)
>I [29/Apr/2011:07:37:28 +0200] Listening to 127.0.0.1:631 (IPv4)
>I [29/Apr/2011:07:37:28 +0200] Listening to /var/run/cups/cups.sock (Domain)
>W [29/Apr/2011:07:37:28 +0200] No limit for CUPS-Get-Document defined in policy default - using Send-Document's policy
>I [29/Apr/2011:07:37:28 +0200] Remote access is disabled.
>D [29/Apr/2011:07:37:28 +0200] Added auto ServerAlias eddrakr
>I [29/Apr/2011:07:37:28 +0200] Loaded configuration file "/etc/cups/cupsd.conf"
>N [29/Apr/2011:07:37:28 +0200] Group and SystemGroup cannot use the same groups!
>I [29/Apr/2011:07:37:28 +0200] Resetting Group to "nobody"...
>I [29/Apr/2011:07:37:28 +0200] Using default TempDir of /var/spool/cups/tmp...
>I [29/Apr/2011:07:37:28 +0200] Configured for up to 100 clients.
>I [29/Apr/2011:07:37:28 +0200] Allowing up to 100 client connections per host.
>I [29/Apr/2011:07:37:28 +0200] Using policy "default" as the default!
>I [29/Apr/2011:07:37:28 +0200] Full reload is required.
>I [29/Apr/2011:07:37:28 +0200] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 36 types, 46 filters...
>D [29/Apr/2011:07:37:28 +0200] Loading printer hp...
>D [29/Apr/2011:07:37:28 +0200] load_ppd: Loading /var/cache/cups/hp.ipp4...
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb77dc1a0(hp))
>D [29/Apr/2011:07:37:28 +0200] load_ppd: Loading /var/cache/cups/hp.ipp4...
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb77dc1a0(hp))
>D [29/Apr/2011:07:37:28 +0200] Loading printer hp_cups...
>D [29/Apr/2011:07:37:28 +0200] load_ppd: Loading /var/cache/cups/hp_cups.ipp4...
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb77f5be8(hp_cups))
>D [29/Apr/2011:07:37:28 +0200] load_ppd: Loading /var/cache/cups/hp_cups.ipp4...
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb77f5be8(hp_cups))
>D [29/Apr/2011:07:37:28 +0200] Loading printer Officejet_Pro_8500_A910...
>D [29/Apr/2011:07:37:28 +0200] load_ppd: Loading /var/cache/cups/Officejet_Pro_8500_A910.ipp4...
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb780e718(Officejet_Pro_8500_A910))
>D [29/Apr/2011:07:37:28 +0200] Loading printer Photosmart_C5100...
>D [29/Apr/2011:07:37:28 +0200] load_ppd: Loading /var/cache/cups/Photosmart_C5100.ipp4...
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb7829da0(Photosmart_C5100))
>D [29/Apr/2011:07:37:28 +0200] Loading printer pipe...
>D [29/Apr/2011:07:37:28 +0200] load_ppd: Loading /var/cache/cups/pipe.ipp4...
>D [29/Apr/2011:07:37:28 +0200] cupsdMarkDirty(P-----)
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>E [29/Apr/2011:07:37:28 +0200] Filter "/usr/lib/cups/filter/foomatic-rip" for printer "pipe" not available: No such file or directory
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb7861680(pipe))
>I [29/Apr/2011:07:37:28 +0200] Loading job cache file "/var/cache/cups/job.cache"...
>D [29/Apr/2011:07:37:28 +0200] [Job 51] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 52] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 53] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 54] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 70] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 71] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 79] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 107] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 108] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] [Job 109] Loading from cache...
>D [29/Apr/2011:07:37:28 +0200] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
>I [29/Apr/2011:07:37:28 +0200] Full reload complete.
>D [29/Apr/2011:07:37:28 +0200] cupsd_clean_files(path="/var/spool/cups/tmp", pattern="(null)")
>I [29/Apr/2011:07:37:28 +0200] Cleaning out old files in "/var/spool/cups/tmp"...
>D [29/Apr/2011:07:37:28 +0200] cupsd_clean_files(path="/var/cache/cups", pattern="*.ipp")
>I [29/Apr/2011:07:37:28 +0200] Cleaning out old files in "/var/cache/cups"...
>I [29/Apr/2011:07:37:28 +0200] Listening to ::1:631 on fd 4...
>I [29/Apr/2011:07:37:28 +0200] Listening to 127.0.0.1:631 on fd 6...
>I [29/Apr/2011:07:37:28 +0200] Listening to /var/run/cups/cups.sock on fd 7...
>I [29/Apr/2011:07:37:28 +0200] Resuming new connection processing...
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb77dc1a0(hp))
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb77f5be8(hp_cups))
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb780e718(Officejet_Pro_8500_A910))
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb7829da0(Photosmart_C5100))
>D [29/Apr/2011:07:37:28 +0200] cupsdRegisterPrinter(p=0xb7861680(pipe))
>D [29/Apr/2011:07:37:28 +0200] Discarding unused server-started event...
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 11 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] Report: clients=1
>D [29/Apr/2011:07:37:28 +0200] Report: jobs=10
>D [29/Apr/2011:07:37:28 +0200] Report: jobs-active=0
>D [29/Apr/2011:07:37:28 +0200] Report: printers=5
>D [29/Apr/2011:07:37:28 +0200] Report: printers-implicit=0
>D [29/Apr/2011:07:37:28 +0200] Report: stringpool-string-count=34406
>D [29/Apr/2011:07:37:28 +0200] Report: stringpool-alloc-bytes=13072
>D [29/Apr/2011:07:37:28 +0200] Report: stringpool-total-bytes=643712
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 11 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 12 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 12 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 12 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 13 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 13 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 14 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 14 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 15 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 15 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 16 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 16 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 17 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 17 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 18 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 18 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 18 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAcceptClient: 19 from localhost (Domain)
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 19 POST / HTTP/1.1
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:28 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:28 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:28 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:28 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:28 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:34 +0200] cupsdAcceptClient: 20 from localhost (Domain)
>D [29/Apr/2011:07:37:34 +0200] cupsdReadClient: 20 POST / HTTP/1.1
>D [29/Apr/2011:07:37:34 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:34 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:34 +0200] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:34 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:34 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:34 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:34 +0200] cupsdAcceptClient: 21 from localhost (Domain)
>D [29/Apr/2011:07:37:34 +0200] cupsdReadClient: 21 POST / HTTP/1.1
>D [29/Apr/2011:07:37:34 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:34 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:34 +0200] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:34 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:34 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:34 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:34 +0200] cupsdAcceptClient: 22 from localhost (Domain)
>D [29/Apr/2011:07:37:34 +0200] cupsdReadClient: 22 POST / HTTP/1.1
>D [29/Apr/2011:07:37:34 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:34 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:34 +0200] cupsdReadClient: 22 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:34 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:34 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:34 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:35 +0200] cupsdAcceptClient: 23 from localhost (Domain)
>D [29/Apr/2011:07:37:35 +0200] cupsdReadClient: 23 POST / HTTP/1.1
>D [29/Apr/2011:07:37:35 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:35 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:35 +0200] cupsdReadClient: 23 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:35 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:35 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:35 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 24 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 24 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 24 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:36 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 25 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 25 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 25 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:36 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 26 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 1.1 Get-Printer-Attributes 1
>D [29/Apr/2011:07:37:36 +0200] Get-Printer-Attributes ipp://localhost:631/printers/Officejet_Pro_8500_A910
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/Officejet_Pro_8500_A910) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 POST /printers/Officejet_Pro_8500_A910 HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 1.1 Create-Job 1
>D [29/Apr/2011:07:37:36 +0200] Create-Job ipp://localhost:631/printers/Officejet_Pro_8500_A910
>D [29/Apr/2011:07:37:36 +0200] cupsdMarkDirty(----J-)
>D [29/Apr/2011:07:37:36 +0200] add_job: requesting-user-name="eddrakr"
>I [29/Apr/2011:07:37:36 +0200] [Job 110] Adding start banner page "none".
>D [29/Apr/2011:07:37:36 +0200] cupsdMarkDirty(-----S)
>I [29/Apr/2011:07:37:36 +0200] [Job 110] Queued on "Officejet_Pro_8500_A910" by "eddrakr".
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/Officejet_Pro_8500_A910) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 POST /printers/Officejet_Pro_8500_A910 HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 1.1 Send-Document 1
>D [29/Apr/2011:07:37:36 +0200] Send-Document ipp://localhost:631/printers/Officejet_Pro_8500_A910
>D [29/Apr/2011:07:37:36 +0200] cupsdIsAuthorized: requesting-user-name="eddrakr"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Auto-typing file...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Request file type is application/postscript.
>D [29/Apr/2011:07:37:36 +0200] cupsdMarkDirty(----J-)
>I [29/Apr/2011:07:37:36 +0200] [Job 110] File of type application/postscript queued by "eddrakr".
>I [29/Apr/2011:07:37:36 +0200] [Job 110] Adding end banner page "none".
>D [29/Apr/2011:07:37:36 +0200] cupsdMarkDirty(----J-)
>D [29/Apr/2011:07:37:36 +0200] cupsdMarkDirty(----J-)
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdMarkDirty(-----S)
>D [29/Apr/2011:07:37:36 +0200] [Job 110] job-sheets=none,none
>D [29/Apr/2011:07:37:36 +0200] [Job 110] argv[0]="Officejet_Pro_8500_A910"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] argv[1]="110"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] argv[2]="eddrakr"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] argv[3]="tmptF1ctI"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] argv[4]="1"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:0308b99c-387b-3393-72a6-5407dfa765ca job-originating-host-name=localhost time-at-creation=1304055456 time-at-processing=1304055456 AP_D_InputSlot="
>D [29/Apr/2011:07:37:36 +0200] [Job 110] argv[6]="/var/spool/cups/d00110-001"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[8]="HOME=/var/spool/cups/tmp"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[10]="SERVER_ADMIN=root@eddrakr"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[11]="SOFTWARE=CUPS/1.4.6"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[12]="TMPDIR=/var/spool/cups/tmp"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[13]="USER=root"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[15]="CUPS_ENCRYPTION=IfRequested"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[16]="IPP_PORT=631"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[17]="CHARSET=utf-8"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[18]="LANG=de_DE.UTF-8"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[19]="PPD=/etc/cups/ppd/Officejet_Pro_8500_A910.ppd"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[20]="RIP_MAX_CACHE=128m"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[21]="CONTENT_TYPE=application/postscript"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[22]="DEVICE_URI=hp:/net/Officejet_Pro_8500_A910?ip=192.168.245.207"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[23]="PRINTER_INFO=Officejet_Pro_8500_A910"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[24]="PRINTER_LOCATION="
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[25]="PRINTER=Officejet_Pro_8500_A910"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[26]="CUPS_FILETYPE=document"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] envp[27]="FINAL_CONTENT_TYPE=printer/Officejet_Pro_8500_A910"
>I [29/Apr/2011:07:37:36 +0200] [Job 110] Started filter /usr/lib/cups/filter/pstops (PID 16613)
>I [29/Apr/2011:07:37:36 +0200] [Job 110] Started filter /usr/lib/cups/filter/foomatic-rip-hplip (PID 16614)
>I [29/Apr/2011:07:37:36 +0200] [Job 110] Started backend /usr/lib/cups/backend/hp (PID 16615)
>D [29/Apr/2011:07:37:36 +0200] cupsdMarkDirty(-----S)
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Officejet_Pro_8500_A910) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 WAITING Closing on EOF
>D [29/Apr/2011:07:37:36 +0200] cupsdCloseClient: 26
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Page = 595x842; 10,36 to 585,833
>D [29/Apr/2011:07:37:36 +0200] [Job 110] slow_collate=0, slow_duplex=0, slow_order=0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Before copy_comments - %!PS-Adobe-3.0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] %!PS-Adobe-3.0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] %%BoundingBox: 0 0 612 792
>D [29/Apr/2011:07:37:36 +0200] [Job 110] %%Pages: 1
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Before copy_prolog - /hplipversion (3.11.3a) def
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Before copy_setup - %%Page: 1 1
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Before page loop - %%Page: 1 1
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Copying page 1...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] pagew = 575.6, pagel = 797.0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
>D [29/Apr/2011:07:37:36 +0200] [Job 110] PageLeft = 9.7, PageRight = 585.3
>D [29/Apr/2011:07:37:36 +0200] [Job 110] PageTop = 833.0, PageBottom = 36.0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] PageWidth = 595.0, PageLength = 842.0
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 26 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 26 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:36 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 30 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 30 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 30 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:36 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] [Job 110] foomatic-rip version $Revision=3.0.2.131$ running...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Parsing PPD file ...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option ColorSpace
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option Resolution
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option PageSize
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option Model
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option PrintoutMode
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option InputSlot
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option Duplex
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option DryTime
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option Quality
>D [29/Apr/2011:07:37:36 +0200] [Job 110] *cupsFilter: "application/vnd.cups-postscript 100 foomatic-rip-hplip"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] *cupsFilter: "application/vnd.cups-pdf 0 foomatic-rip-hplip"
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 31 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option PageRegion
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 1.1 Get-Notifications 1
>D [29/Apr/2011:07:37:36 +0200] Get-Notifications /
>D [29/Apr/2011:07:37:36 +0200] cupsdIsAuthorized: requesting-user-name="eddrakr"
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option ImageableArea
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 1.1 Get-Job-Attributes 1
>D [29/Apr/2011:07:37:36 +0200] Get-Job-Attributes ipp://localhost/jobs/110
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/110) from localhost
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option PaperDimension
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 32 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 32 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 32 1.1 Get-Printer-Attributes 1
>D [29/Apr/2011:07:37:36 +0200] Get-Printer-Attributes ipp://eddrakr/printers/Officejet_Pro_8500_A910
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Get-Printer-Attributes (ipp://eddrakr/printers/Officejet_Pro_8500_A910) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 32 WAITING Closing on EOF
>D [29/Apr/2011:07:37:36 +0200] cupsdCloseClient: 32
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Added option Font
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Parameter Summary
>D [29/Apr/2011:07:37:36 +0200] [Job 110] -----------------
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Spooler: cups
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Printer: Officejet_Pro_8500_A910
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Shell: /bin/sh
>D [29/Apr/2011:07:37:36 +0200] [Job 110] PPD file: /etc/cups/ppd/Officejet_Pro_8500_A910.ppd
>D [29/Apr/2011:07:37:36 +0200] [Job 110] ATTR file: 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Printer model: HP Officejet Pro 8500 a910 hpijs, 3.11.3a
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Job title: tmptF1ctI
>D [29/Apr/2011:07:37:36 +0200] [Job 110] File(s) to be printed: 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] <STDIN>
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] GhostScript extra search path ('GS_LIB'): /usr/share/cups/fonts
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Pondering option 'finishings=3'
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Unknown option finishings=3.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Pondering option 'number-up=1'
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Unknown option number-up=1.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Pondering option 'job-uuid=urn:uuid:0308b99c-387b-3393-72a6-5407dfa765ca'
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Unknown option job-uuid=urn:uuid:0308b99c-387b-3393-72a6-5407dfa765ca.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Pondering option 'job-originating-host-name=localhost'
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Unknown option job-originating-host-name=localhost.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Pondering option 'time-at-creation=1304055456'
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Unknown option time-at-creation=1304055456.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Pondering option 'time-at-processing=1304055456'
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Unknown option time-at-processing=1304055456.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Pondering option 'AP_D_InputSlot='
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Unknown option AP_D_InputSlot=.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] ================================================
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] File: <STDIN>
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] ================================================
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Reading PostScript input ...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] --> This document is DSC-conforming!
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %RBINumCopies: 1
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] -----------
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginProlog
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%EndProlog
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] -----------
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginSetup
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginFeature: *PageSize A4
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: PageSize=A4 --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %% FoomaticRIPOptionSetting: PageSize=A4
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: PageSize=A4 --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginFeature: *PrintoutMode Normal
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: PrintoutMode=Normal --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %% FoomaticRIPOptionSetting: PrintoutMode=Normal
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: PrintoutMode=Normal --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginFeature: *Quality FromPrintoutMode
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: Quality=FromPrintoutMode --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %% FoomaticRIPOptionSetting: Quality=@PrintoutMode
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: Quality=FromPrintoutMode --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginFeature: *Duplex None
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: Duplex=None --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %% FoomaticRIPOptionSetting: Duplex=None
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: Duplex=None --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginFeature: *DryTime Zero
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: DryTime=Zero --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %% FoomaticRIPOptionSetting: DryTime=Zero
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Option: DryTime=Zero --> Setting option
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%EndSetup
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Inserting PostScript code for CUPS' page accounting
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] -----------
>D [29/Apr/2011:07:37:36 +0200] [Job 110] New page:  1 1
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%BeginPageSetup
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Inserting option code into "PageSetup" section.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found: %%EndPageSetup
>D [29/Apr/2011:07:37:36 +0200] [Job 110] End of page header
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Stopping search for page header options
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Found:       lineto				% Move there...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] --> Output goes directly to the renderer now.
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Starting renderer
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 WAITING Closing on EOF
>D [29/Apr/2011:07:37:36 +0200] cupsdCloseClient: 31
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 31 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 1.1 Get-Notifications 1
>D [29/Apr/2011:07:37:36 +0200] Get-Notifications /
>D [29/Apr/2011:07:37:36 +0200] cupsdIsAuthorized: requesting-user-name="eddrakr"
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 WAITING Closing on EOF
>D [29/Apr/2011:07:37:36 +0200] cupsdCloseClient: 31
>D [29/Apr/2011:07:37:36 +0200] cupsdAcceptClient: 31 from localhost (Domain)
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 POST / HTTP/1.1
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Active clients, printing jobs, and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 1.1 Get-Notifications 1
>D [29/Apr/2011:07:37:36 +0200] Get-Notifications /
>D [29/Apr/2011:07:37:36 +0200] cupsdIsAuthorized: requesting-user-name="eddrakr"
>D [29/Apr/2011:07:37:36 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost
>D [29/Apr/2011:07:37:36 +0200] cupsdSetBusyState: Printing jobs and dirty files
>D [29/Apr/2011:07:37:36 +0200] cupsdReadClient: 31 WAITING Closing on EOF
>D [29/Apr/2011:07:37:36 +0200] cupsdCloseClient: 31
>D [29/Apr/2011:07:37:36 +0200] [Job 110] renderer PID kid4=16620
>D [29/Apr/2011:07:37:36 +0200] [Job 110] renderer command: gs -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -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=- -
>D [29/Apr/2011:07:37:36 +0200] [Job 110] JCL: <job data> 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] 
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Starting process 16621: "gs -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -dDEVICEWIDTHPOINTS=5..."
>D [29/Apr/2011:07:37:36 +0200] [Job 110] prnt/hpijs/hpijs.cpp 638: unable to open PrintContext object err=2
>D [29/Apr/2011:07:37:36 +0200] [Job 110] GPL Ghostscript  9.00: Can't start ijs server "hpijs"
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Process 16621 ending: "gs -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -dDEVICEWIDTHPOINTS=5..."
>D [29/Apr/2011:07:37:36 +0200] [Job 110] renderer return value: 1
>D [29/Apr/2011:07:37:36 +0200] [Job 110] renderer received signal: 1
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Process dying with "Possible error on renderer command line or PostScript error. Check options.", exit stat: 3
>D [29/Apr/2011:07:37:36 +0200] [Job 110] error: Datei oder Verzeichnis nicht gefunden (2)
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Cleaning up ...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Killing process 16620 (KID4) with signal 15
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Process dying with "Caught termination signal: Job canceled", exit stat: 0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] error:  (0)
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Cleaning up ...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Process dying with "Caught termination signal: Job canceled", exit stat: 0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] error: DatenÃ¼bergabe unterbrochen (broken pipe) (32)
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Cleaning up ...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Killing process 16619 (KID3) with signal 15
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Process dying with "Caught termination signal: Job canceled", exit stat: 0
>D [29/Apr/2011:07:37:36 +0200] [Job 110] error: Unterbrechung wÃ¤hrend des Betriebssystemaufrufs (4)
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Cleaning up ...
>D [29/Apr/2011:07:37:36 +0200] [Job 110] Killing process 16620 (KID4) with signal 15
>D [29/Apr/2011:07:37:39 +0200] [Job 110] 
>D [29/Apr/2011:07:37:39 +0200] [Job 110] Closing foomatic-rip.
>D [29/Apr/2011:07:37:40 +0200] [Job 110] Killing process 16620 (KID4) with signal 9
>D [29/Apr/2011:07:37:40 +0200] [Job 110] 
>D [29/Apr/2011:07:37:40 +0200] [Job 110] Closing foomatic-rip.
>D [29/Apr/2011:07:37:41 +0200] [Job 110] Killing process 16619 (KID3) with signal 9
>D [29/Apr/2011:07:37:41 +0200] [Job 110] Caught termination signal: Job canceled
>D [29/Apr/2011:07:37:41 +0200] [Job 110] 
>D [29/Apr/2011:07:37:41 +0200] [Job 110] Closing foomatic-rip.
>D [29/Apr/2011:07:37:41 +0200] [Job 110] prnt/backend/hp.c 839: ERROR: null print job total=0
>D [29/Apr/2011:07:37:41 +0200] PID 16613 (/usr/lib/cups/filter/pstops) did not catch or ignore signal 13.
>D [29/Apr/2011:07:37:41 +0200] cupsdAcceptClient: 31 from localhost (Domain)
>D [29/Apr/2011:07:37:41 +0200] PID 16614 (/usr/lib/cups/filter/foomatic-rip-hplip) exited with no errors.
>D [29/Apr/2011:07:37:41 +0200] PID 16615 (/usr/lib/cups/backend/hp) exited with no errors.
>D [29/Apr/2011:07:37:41 +0200] cupsdMarkDirty(-----S)
>I [29/Apr/2011:07:37:41 +0200] [Job 110] Job completed.
>D [29/Apr/2011:07:37:41 +0200] cupsdMarkDirty(----J-)
>D [29/Apr/2011:07:37:41 +0200] cupsdMarkDirty(-----S)
>D [29/Apr/2011:07:37:41 +0200] cupsdReadClient: 31 POST / HTTP/1.1
>D [29/Apr/2011:07:37:41 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:41 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:41 +0200] cupsdReadClient: 31 1.1 CUPS-Get-Printers 1
>D [29/Apr/2011:07:37:41 +0200] CUPS-Get-Printers
>D [29/Apr/2011:07:37:41 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [29/Apr/2011:07:37:41 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:42 +0200] cupsdAcceptClient: 29 from localhost (Domain)
>D [29/Apr/2011:07:37:42 +0200] [Job 110] Unloading...
>D [29/Apr/2011:07:37:42 +0200] cupsdReadClient: 29 POST / HTTP/1.1
>D [29/Apr/2011:07:37:42 +0200] cupsdSetBusyState: Active clients and dirty files
>D [29/Apr/2011:07:37:42 +0200] cupsdAuthorize: No authentication data provided.
>D [29/Apr/2011:07:37:42 +0200] cupsdReadClient: 29 1.1 Get-Notifications 1
>D [29/Apr/2011:07:37:42 +0200] Get-Notifications /
>D [29/Apr/2011:07:37:42 +0200] cupsdIsAuthorized: requesting-user-name="eddrakr"
>D [29/Apr/2011:07:37:42 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost
>D [29/Apr/2011:07:37:42 +0200] cupsdSetBusyState: Dirty files
>D [29/Apr/2011:07:37:42 +0200] cupsdReadClient: 29 WAITING Closing on EOF
>D [29/Apr/2011:07:37:42 +0200] cupsdCloseClient: 29
>I [29/Apr/2011:07:37:54 +0200] Scheduler shutting down normally.
>D [29/Apr/2011:07:37:54 +0200] Discarding unused server-stopped event...
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 11
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 12
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 13
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 14
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 15
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 16
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 17
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 18
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 19
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 20
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 21
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 22
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 23
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 24
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 25
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 26
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 30
>D [29/Apr/2011:07:37:54 +0200] cupsdCloseClient: 31
>D [29/Apr/2011:07:37:54 +0200] cupsdDeregisterPrinter(p=0xb77dc1a0(hp), removeit=1)
>D [29/Apr/2011:07:37:54 +0200] cupsdDeregisterPrinter(p=0xb77f5be8(hp_cups), removeit=1)
>D [29/Apr/2011:07:37:54 +0200] cupsdDeregisterPrinter(p=0xb780e718(Officejet_Pro_8500_A910), removeit=1)
>D [29/Apr/2011:07:37:54 +0200] cupsdDeregisterPrinter(p=0xb7829da0(Photosmart_C5100), removeit=1)
>D [29/Apr/2011:07:37:54 +0200] cupsdDeregisterPrinter(p=0xb7861680(pipe), removeit=1)
>I [29/Apr/2011:07:37:54 +0200] Saving printers.conf...
>I [29/Apr/2011:07:37:54 +0200] Saving job cache file "/var/cache/cups/job.cache"...
>I [29/Apr/2011:07:37:54 +0200] Saving subscriptions.conf...
>D [29/Apr/2011:07:37:54 +0200] cupsdSetBusyState: Not busy
>I [29/Apr/2011:07:37:54 +0200] Saving job cache file "/var/cache/cups/job.cache"...

Actions: View

Attachments on bug 688614: 426187 | 427210 | 427211 | 427212 | 427226