I [03/Dec/2011:08:36:28 +0100] Listening to [v1.::1]:631 (IPv6)
I [03/Dec/2011:08:36:28 +0100] Listening to 127.0.0.1:631 (IPv4)
I [03/Dec/2011:08:36:28 +0100] Listening to /var/run/cups/cups.sock (Domain)
I [03/Dec/2011:08:36:28 +0100] Remote access is disabled.
D [03/Dec/2011:08:36:28 +0100] Added auto ServerAlias krzysztof-desktop
I [03/Dec/2011:08:36:28 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
I [03/Dec/2011:08:36:28 +0100] Using default TempDir of /var/spool/cups/tmp...
I [03/Dec/2011:08:36:28 +0100] Configured for up to 100 clients.
I [03/Dec/2011:08:36:28 +0100] Allowing up to 100 client connections per host.
I [03/Dec/2011:08:36:28 +0100] Using policy "default" as the default!
I [03/Dec/2011:08:36:28 +0100] Full reload is required.
I [03/Dec/2011:08:36:28 +0100] Saving job cache file "/var/cache/cups/job.cache"...
D [03/Dec/2011:08:36:28 +0100] cupsdDeregisterPrinter(p=0x21c542f0(Photosmart-2570-series), removeit=1)
I [03/Dec/2011:08:36:28 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 38 types, 77 filters...
D [03/Dec/2011:08:36:28 +0100] Loading printer Photosmart-2570-series...
D [03/Dec/2011:08:36:28 +0100] load_ppd: Loading /var/cache/cups/Photosmart-2570-series.ipp4...
D [03/Dec/2011:08:36:28 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
D [03/Dec/2011:08:36:28 +0100] cupsdLoadRemoteCache: Not loading remote cache.
I [03/Dec/2011:08:36:28 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [03/Dec/2011:08:36:28 +0100] [Job 1] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 2] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 3] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 4] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 5] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 6] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 7] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 8] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 9] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 10] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 11] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 12] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 13] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 14] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 15] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 16] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 17] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 18] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 19] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 20] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 21] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 22] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 23] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 24] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 25] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 26] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 27] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 28] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 29] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 30] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 31] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 32] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 33] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 34] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 35] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 36] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 37] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 38] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 39] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 40] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 41] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 42] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 43] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 44] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 45] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 46] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 47] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 48] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 49] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 50] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 51] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 52] Loading from cache...
D [03/Dec/2011:08:36:28 +0100] [Job 53] Loading from cache...
I [03/Dec/2011:08:36:28 +0100] Full reload complete.
I [03/Dec/2011:08:36:28 +0100] Listening to [v1.::1]:631 on fd 5...
I [03/Dec/2011:08:36:28 +0100] Listening to 127.0.0.1:631 on fd 7...
I [03/Dec/2011:08:36:28 +0100] Listening to /var/run/cups/cups.sock on fd 8...
I [03/Dec/2011:08:36:28 +0100] Resuming new connection processing...
D [03/Dec/2011:08:36:28 +0100] Discarding unused server-restarted event...
D [03/Dec/2011:08:36:29 +0100] Report: clients=0
D [03/Dec/2011:08:36:29 +0100] Report: jobs=53
D [03/Dec/2011:08:36:29 +0100] Report: jobs-active=0
D [03/Dec/2011:08:36:29 +0100] Report: printers=1
D [03/Dec/2011:08:36:29 +0100] Report: printers-implicit=0
D [03/Dec/2011:08:36:29 +0100] Report: stringpool-string-count=23151
D [03/Dec/2011:08:36:29 +0100] Report: stringpool-alloc-bytes=10032
D [03/Dec/2011:08:36:29 +0100] Report: stringpool-total-bytes=430144
D [03/Dec/2011:10:20:50 +0100] cupsdAcceptClient: 11 from localhost (Domain)
D [03/Dec/2011:10:20:50 +0100] Report: clients=1
D [03/Dec/2011:10:20:50 +0100] Report: jobs=53
D [03/Dec/2011:10:20:50 +0100] Report: jobs-active=0
D [03/Dec/2011:10:20:50 +0100] Report: printers=1
D [03/Dec/2011:10:20:50 +0100] Report: printers-implicit=0
D [03/Dec/2011:10:20:50 +0100] Report: stringpool-string-count=23151
D [03/Dec/2011:10:20:50 +0100] Report: stringpool-alloc-bytes=10032
D [03/Dec/2011:10:20:50 +0100] Report: stringpool-total-bytes=430144
D [03/Dec/2011:10:20:50 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:10:20:50 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:10:20:50 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:10:20:50 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:10:20:50 +0100] CUPS-Get-Printers
D [03/Dec/2011:10:20:50 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:10:20:50 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:10:20:50 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:10:20:50 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:10:20:50 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:10:20:50 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:10:20:50 +0100] CUPS-Get-Default
D [03/Dec/2011:10:20:50 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:10:20:50 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:10:25:51 +0100] Closing client 11 after 300 seconds of inactivity...
D [03/Dec/2011:10:25:51 +0100] cupsdCloseClient: 11
D [03/Dec/2011:10:25:51 +0100] Report: clients=0
D [03/Dec/2011:10:25:51 +0100] Report: jobs=53
D [03/Dec/2011:10:25:51 +0100] Report: jobs-active=0
D [03/Dec/2011:10:25:51 +0100] Report: printers=1
D [03/Dec/2011:10:25:51 +0100] Report: printers-implicit=0
D [03/Dec/2011:10:25:51 +0100] Report: stringpool-string-count=23151
D [03/Dec/2011:10:25:51 +0100] Report: stringpool-alloc-bytes=10032
D [03/Dec/2011:10:25:51 +0100] Report: stringpool-total-bytes=430144
D [03/Dec/2011:10:38:40 +0100] Report: clients=0
D [03/Dec/2011:10:38:40 +0100] Report: jobs=53
D [03/Dec/2011:10:38:40 +0100] Report: jobs-active=0
D [03/Dec/2011:10:38:40 +0100] Report: printers=1
D [03/Dec/2011:10:38:40 +0100] Report: printers-implicit=0
D [03/Dec/2011:10:38:40 +0100] Report: stringpool-string-count=23151
D [03/Dec/2011:10:38:40 +0100] Report: stringpool-alloc-bytes=10032
D [03/Dec/2011:10:38:40 +0100] Report: stringpool-total-bytes=430144
D [03/Dec/2011:11:16:55 +0100] Report: clients=0
D [03/Dec/2011:11:16:55 +0100] Report: jobs=53
D [03/Dec/2011:11:16:55 +0100] Report: jobs-active=0
D [03/Dec/2011:11:16:55 +0100] Report: printers=1
D [03/Dec/2011:11:16:55 +0100] Report: printers-implicit=0
D [03/Dec/2011:11:16:55 +0100] Report: stringpool-string-count=23151
D [03/Dec/2011:11:16:55 +0100] Report: stringpool-alloc-bytes=10032
D [03/Dec/2011:11:16:55 +0100] Report: stringpool-total-bytes=430144
D [03/Dec/2011:12:57:03 +0100] cupsdAcceptClient: 11 from localhost (Domain)
D [03/Dec/2011:12:57:03 +0100] Report: clients=1
D [03/Dec/2011:12:57:03 +0100] Report: jobs=53
D [03/Dec/2011:12:57:03 +0100] Report: jobs-active=0
D [03/Dec/2011:12:57:03 +0100] Report: printers=1
D [03/Dec/2011:12:57:03 +0100] Report: printers-implicit=0
D [03/Dec/2011:12:57:03 +0100] Report: stringpool-string-count=23151
D [03/Dec/2011:12:57:03 +0100] Report: stringpool-alloc-bytes=10032
D [03/Dec/2011:12:57:03 +0100] Report: stringpool-total-bytes=430144
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:03 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:03 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:03 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Printers
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:12:57:04 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:12:57:04 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Default 1
D [03/Dec/2011:12:57:04 +0100] CUPS-Get-Default
D [03/Dec/2011:12:57:04 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:12:57:04 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:12:57:12 +0100] cupsdReadClient: 11 WAITING Closing on EOF
D [03/Dec/2011:12:57:12 +0100] cupsdCloseClient: 11
D [03/Dec/2011:13:11:34 +0100] cupsdAcceptClient: 11 from localhost (Domain)
D [03/Dec/2011:13:11:34 +0100] Report: clients=1
D [03/Dec/2011:13:11:34 +0100] Report: jobs=53
D [03/Dec/2011:13:11:34 +0100] Report: jobs-active=0
D [03/Dec/2011:13:11:34 +0100] Report: printers=1
D [03/Dec/2011:13:11:34 +0100] Report: printers-implicit=0
D [03/Dec/2011:13:11:34 +0100] Report: stringpool-string-count=23151
D [03/Dec/2011:13:11:34 +0100] Report: stringpool-alloc-bytes=10032
D [03/Dec/2011:13:11:34 +0100] Report: stringpool-total-bytes=430144
D [03/Dec/2011:13:11:34 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:13:11:34 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:11:34 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:11:34 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Devices 1
D [03/Dec/2011:13:11:34 +0100] CUPS-Get-Devices
D [03/Dec/2011:13:11:34 +0100] cupsdIsAuthorized: username=""
D [03/Dec/2011:13:11:34 +0100] Returning HTTP Unauthorized for CUPS-Get-Devices (no URI) from localhost
D [03/Dec/2011:13:11:34 +0100] cupsdSendHeader: 11 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [03/Dec/2011:13:11:34 +0100] cupsdReadClient: 11 WAITING Closing on EOF
D [03/Dec/2011:13:11:34 +0100] cupsdCloseClient: 11
D [03/Dec/2011:13:11:34 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:11:34 +0100] cupsdAcceptClient: 11 from localhost (Domain)
D [03/Dec/2011:13:11:34 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [03/Dec/2011:13:11:34 +0100] cupsdReadClient: 11 WAITING Closing on EOF
D [03/Dec/2011:13:11:34 +0100] cupsdCloseClient: 11
D [03/Dec/2011:13:11:34 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [03/Dec/2011:13:11:34 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:11:34 +0100] cupsdAuthorize: Authorized as root using PeerCred
D [03/Dec/2011:13:11:34 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Devices 1
D [03/Dec/2011:13:11:34 +0100] CUPS-Get-Devices
D [03/Dec/2011:13:11:34 +0100] cupsdIsAuthorized: username="root"
D [03/Dec/2011:13:11:34 +0100] [CGI] argv[0] = "/usr/lib/cups/daemon/cups-deviced"
D [03/Dec/2011:13:11:34 +0100] [CGI] argv[1] = "1"
D [03/Dec/2011:13:11:34 +0100] [CGI] argv[2] = "0"
D [03/Dec/2011:13:11:34 +0100] [CGI] argv[3] = "2"
D [03/Dec/2011:13:11:34 +0100] [CGI] argv[4] = "7"
D [03/Dec/2011:13:11:34 +0100] [CGI] argv[5] = "requested-attributes=all exclude-schemes='beh','cups-pdf','bluetooth','dnssd','http','https','ipp','lpd','ncp','parallel','scsi','smb','snmp','socket'"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc-root"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@krzysztof-desktop"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.6"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[13] = "USER=root"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[17] = "AUTH_TYPE=PeerCred"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[18] = "LANG=en_US.UTF8"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[19] = "REDIRECT_STATUS=1"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[21] = "SERVER_NAME=localhost"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[22] = "SERVER_PORT=631"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[23] = "REMOTE_ADDR="
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[24] = "REMOTE_HOST=localhost"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[25] = "SCRIPT_NAME=/"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/doc-root/"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[27] = "REMOTE_USER=root"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[28] = "SERVER_PROTOCOL=HTTP/1.1"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[29] = "HTTP_USER_AGENT=CUPS/1.4.6"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[30] = "REQUEST_METHOD=POST"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[31] = "CONTENT_LENGTH=244"
D [03/Dec/2011:13:11:34 +0100] [CGI] envp[32] = "CONTENT_TYPE=application/ipp"
D [03/Dec/2011:13:11:34 +0100] [CGI] Started /usr/lib/cups/daemon/cups-deviced (PID 4045)
I [03/Dec/2011:13:11:34 +0100] Started "/usr/lib/cups/daemon/cups-deviced" (pid=4045)
D [03/Dec/2011:13:11:34 +0100] cupsdSendCommand: 14 file=11
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Started backend /usr/lib/cups/backend/hp (PID 4046)
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Started backend /usr/lib/cups/backend/usb (PID 4047)
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Started backend /usr/lib/cups/backend/serial (PID 4048)
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Started backend /usr/lib/cups/backend/hpfax (PID 4049)
D [03/Dec/2011:13:11:34 +0100] [CGI] list_devices_libusb
D [03/Dec/2011:13:11:34 +0100] [CGI] usb_find_busses=3
D [03/Dec/2011:13:11:34 +0100] [CGI] usb_find_devices=4
D [03/Dec/2011:13:11:34 +0100] [CGI] Flushed attributes...
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Found device "usb://HP/Photosmart%202570%20series?serial=MY68P1116504DY"...
D [03/Dec/2011:13:11:34 +0100] Script header: Content-Type: application/ipp
D [03/Dec/2011:13:11:34 +0100] Script header: 
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] PID 4047 (usb) exited with no errors.
D [03/Dec/2011:13:11:34 +0100] [CGI] Flushed attributes...
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Found device "serial:/dev/ttyS0?baud=115200"...
D [03/Dec/2011:13:11:34 +0100] [CGI] Flushed attributes...
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Found device "serial:/dev/ttyS1?baud=115200"...
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] PID 4048 (serial) exited with no errors.
D [03/Dec/2011:13:11:34 +0100] [CGI] Flushed attributes...
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] Found device "hp:/usb/Photosmart_2570_series?serial=MY68P1116504DY"...
D [03/Dec/2011:13:11:34 +0100] [cups-deviced] PID 4046 (hp) exited with no errors.
D [03/Dec/2011:13:11:36 +0100] PID 4045 (/usr/lib/cups/daemon/cups-deviced) exited with no errors.
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 14
D [03/Dec/2011:13:11:36 +0100] cupsdAcceptClient: 11 from localhost (Domain)
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 11 POST / HTTP/1.1
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:11:36 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:11:36 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:11:36 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 11 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 11
D [03/Dec/2011:13:11:36 +0100] cupsdAcceptClient: 11 from localhost (Domain)
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 11 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:11:36 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 11 1.1 Resume-Printer 1
D [03/Dec/2011:13:11:36 +0100] Resume-Printer ipp://localhost:631/printers/Photosmart-2570-series
D [03/Dec/2011:13:11:36 +0100] cupsdIsAuthorized: username=""
D [03/Dec/2011:13:11:36 +0100] Returning HTTP Unauthorized for Resume-Printer (ipp://localhost:631/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:11:36 +0100] cupsdSendHeader: 11 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 11 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 11
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:11:36 +0100] cupsdAcceptClient: 11 from localhost (Domain)
D [03/Dec/2011:13:11:36 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 11 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 11
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:11:36 +0100] cupsdAuthorize: Authorized as root using PeerCred
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 1.1 Resume-Printer 1
D [03/Dec/2011:13:11:36 +0100] Resume-Printer ipp://localhost:631/printers/Photosmart-2570-series
D [03/Dec/2011:13:11:36 +0100] cupsdIsAuthorized: username="root"
D [03/Dec/2011:13:11:36 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:11:36 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:11:36 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
D [03/Dec/2011:13:11:36 +0100] cupsdMarkDirty(P-----)
I [03/Dec/2011:13:11:36 +0100] Printer "Photosmart-2570-series" started by "root".
D [03/Dec/2011:13:11:36 +0100] Returning IPP successful-ok for Resume-Printer (ipp://localhost:631/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 14
D [03/Dec/2011:13:11:36 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:11:36 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 1.1 Resume-Printer 1
D [03/Dec/2011:13:11:36 +0100] Resume-Printer ipp://localhost:631/printers/Photosmart-2570-series
D [03/Dec/2011:13:11:36 +0100] cupsdIsAuthorized: username=""
D [03/Dec/2011:13:11:36 +0100] Returning HTTP Unauthorized for Resume-Printer (ipp://localhost:631/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:11:36 +0100] cupsdSendHeader: 14 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 14
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:11:36 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [03/Dec/2011:13:11:36 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 14
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 15 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:11:36 +0100] cupsdAuthorize: Authorized as root using PeerCred
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 15 1.1 Resume-Printer 1
D [03/Dec/2011:13:11:36 +0100] Resume-Printer ipp://localhost:631/printers/Photosmart-2570-series
D [03/Dec/2011:13:11:36 +0100] cupsdIsAuthorized: username="root"
D [03/Dec/2011:13:11:36 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
I [03/Dec/2011:13:11:36 +0100] Printer "Photosmart-2570-series" started by "root".
D [03/Dec/2011:13:11:36 +0100] Returning IPP successful-ok for Resume-Printer (ipp://localhost:631/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:11:36 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:11:36 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [03/Dec/2011:13:11:36 +0100] cupsdCloseClient: 15
I [03/Dec/2011:13:12:07 +0100] Saving printers.conf...
D [03/Dec/2011:13:12:07 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:25:55 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [03/Dec/2011:13:25:55 +0100] Report: clients=1
D [03/Dec/2011:13:25:55 +0100] Report: jobs=53
D [03/Dec/2011:13:25:55 +0100] Report: jobs-active=0
D [03/Dec/2011:13:25:55 +0100] Report: printers=1
D [03/Dec/2011:13:25:55 +0100] Report: printers-implicit=0
D [03/Dec/2011:13:25:55 +0100] Report: stringpool-string-count=23150
D [03/Dec/2011:13:25:55 +0100] Report: stringpool-alloc-bytes=10016
D [03/Dec/2011:13:25:55 +0100] Report: stringpool-total-bytes=430136
D [03/Dec/2011:13:25:55 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [03/Dec/2011:13:25:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:25:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:25:55 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:25:55 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:25:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:25:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:25:55 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [03/Dec/2011:13:25:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:25:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:25:55 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:25:55 +0100] CUPS-Get-Default
D [03/Dec/2011:13:25:55 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:25:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:26:44 +0100] cupsdReadClient: 14 POST /printers/Photosmart-2570-series HTTP/1.1
D [03/Dec/2011:13:26:44 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:26:44 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:26:44 +0100] cupsdReadClient: 14 1.1 Create-Job 1
D [03/Dec/2011:13:26:44 +0100] Create-Job ipp://localhost:631/printers/Photosmart-2570-series
D [03/Dec/2011:13:26:44 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:26:44 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:26:44 +0100] add_job: requesting-user-name="krzysztof"
D [03/Dec/2011:13:26:44 +0100] Adding default job-sheets values "none,none"...
I [03/Dec/2011:13:26:44 +0100] [Job 54] Adding start banner page "none".
D [03/Dec/2011:13:26:44 +0100] Discarding unused job-created event...
I [03/Dec/2011:13:26:44 +0100] [Job 54] Queued on "Photosmart-2570-series" by "krzysztof".
D [03/Dec/2011:13:26:44 +0100] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:26:44 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:26:44 +0100] cupsdReadClient: 14 POST /printers/Photosmart-2570-series HTTP/1.1
D [03/Dec/2011:13:26:44 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:26:44 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:26:44 +0100] cupsdReadClient: 14 1.1 Send-Document 1
D [03/Dec/2011:13:26:44 +0100] Send-Document ipp://localhost:631/printers/Photosmart-2570-series
D [03/Dec/2011:13:26:44 +0100] cupsdIsAuthorized: requesting-user-name="krzysztof"
D [03/Dec/2011:13:26:44 +0100] [Job 54] Auto-typing file...
D [03/Dec/2011:13:26:44 +0100] [Job 54] Request file type is application/postscript.
D [03/Dec/2011:13:26:44 +0100] cupsdMarkDirty(----J-)
I [03/Dec/2011:13:26:44 +0100] [Job 54] File of type application/postscript queued by "krzysztof".
I [03/Dec/2011:13:26:44 +0100] [Job 54] Adding end banner page "none".
D [03/Dec/2011:13:26:44 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:26:44 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:26:44 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:26:44 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:26:44 +0100] [Job 54] job-sheets=none,none
D [03/Dec/2011:13:26:44 +0100] [Job 54] argv[0]="Photosmart-2570-series"
D [03/Dec/2011:13:26:44 +0100] [Job 54] argv[1]="54"
D [03/Dec/2011:13:26:44 +0100] [Job 54] argv[2]="krzysztof"
D [03/Dec/2011:13:26:44 +0100] [Job 54] argv[3]="geogeo"
D [03/Dec/2011:13:26:44 +0100] [Job 54] argv[4]="1"
D [03/Dec/2011:13:26:44 +0100] [Job 54] argv[5]="Duplex=None InputSlot=Auto OutputMode=Best PageSize=A4 job-uuid=urn:uuid:6e77958c-fb40-3fb4-584b-449c48759b6c job-originating-host-name=localhost time-at-creation=1322915204 time-at-processing=1322915204"
D [03/Dec/2011:13:26:44 +0100] [Job 54] argv[6]="/var/spool/cups/d00054-001"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[8]="HOME=/var/spool/cups/tmp"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[10]="SERVER_ADMIN=root@krzysztof-desktop"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[11]="SOFTWARE=CUPS/1.4.6"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[13]="USER=root"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[16]="IPP_PORT=631"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[17]="CHARSET=utf-8"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[18]="LANG=pl_PL.UTF-8"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[19]="PPD=/etc/cups/ppd/Photosmart-2570-series.ppd"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[20]="RIP_MAX_CACHE=auto"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[21]="CONTENT_TYPE=application/postscript"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[22]="DEVICE_URI=hp:/usb/Photosmart_2570_series?serial=MY68P1116504DY"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[23]="PRINTER_INFO=HP Photosmart 2570 series"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[24]="PRINTER_LOCATION=krzysztof-desktop"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[25]="PRINTER=Photosmart-2570-series"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[26]="CUPS_FILETYPE=document"
D [03/Dec/2011:13:26:44 +0100] [Job 54] envp[27]="FINAL_CONTENT_TYPE=printer/Photosmart-2570-series"
I [03/Dec/2011:13:26:44 +0100] [Job 54] Started filter /usr/lib/cups/filter/pstopdf (PID 4131)
I [03/Dec/2011:13:26:44 +0100] [Job 54] Started filter /usr/lib/cups/filter/pdftopdf (PID 4132)
I [03/Dec/2011:13:26:44 +0100] [Job 54] Started filter /usr/lib/cups/filter/pdftoraster-poppler (PID 4133)
I [03/Dec/2011:13:26:44 +0100] [Job 54] Started filter /usr/lib/cups/filter/hpcups (PID 4134)
I [03/Dec/2011:13:26:44 +0100] [Job 54] Started backend /usr/lib/cups/backend/hp (PID 4135)
D [03/Dec/2011:13:26:44 +0100] Discarding unused job-state-changed event...
D [03/Dec/2011:13:26:44 +0100] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:26:44 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:26:44 +0100] [Job 54] pstopdf 6 args: 54 krzysztof geogeo 1 Duplex=None InputSlot=Auto OutputMode=Best PageSize=A4 job-uuid=urn:uuid:6e77958c-fb40-3fb4-584b-449c48759b6c job-originating-host-name=localhost time-at-creation=1322915204 time-at-processing=1322915204 /var/spool/cups/d00054-001
D [03/Dec/2011:13:26:44 +0100] [Job 54] PPD: /etc/cups/ppd/Photosmart-2570-series.ppd
D [03/Dec/2011:13:26:44 +0100] [Job 54] Resolution: 
D [03/Dec/2011:13:26:44 +0100] [Job 54] Page size: A4
D [03/Dec/2011:13:26:44 +0100] [Job 54] Width: 595, height: 833, absolute margins: 9, 27, 586, 797
D [03/Dec/2011:13:26:44 +0100] [Job 54] Relative margins: 9, 27, 9, 36
D [03/Dec/2011:13:26:44 +0100] [Job 54] PPD options: -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=833
D [03/Dec/2011:13:26:44 +0100] [Job 54] PostScript to be injected: 
D [03/Dec/2011:13:26:44 +0100] [Job 54] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode                 -dPDFSETTINGS=/printer                 -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=833 -sOutputFile=-  -c .setpdfwrite -f -
D [03/Dec/2011:13:26:47 +0100] PID 4131 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [03/Dec/2011:13:26:47 +0100] [Job 54] mediaBox = [ 0.000000 0.000000 595.000000 833.000000 ]
D [03/Dec/2011:13:26:47 +0100] [Job 54] size = A4
D [03/Dec/2011:13:26:47 +0100] PID 4132 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [03/Dec/2011:13:26:50 +0100] [Job 54] PAGE: 1 1
D [03/Dec/2011:13:26:50 +0100] Discarding unused job-progress event...
D [03/Dec/2011:13:26:50 +0100] [Job 54] STATE: +connecting-to-device
D [03/Dec/2011:13:26:50 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:26:50 +0100] [Job 54] STATE: -connecting-to-device
D [03/Dec/2011:13:26:50 +0100] [Job 54] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [03/Dec/2011:13:26:50 +0100] Discarding unused printer-state-changed event...
I [03/Dec/2011:13:27:15 +0100] Saving job cache file "/var/cache/cups/job.cache"...
D [03/Dec/2011:13:27:15 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:27:15 +0100] Report: clients=1
D [03/Dec/2011:13:27:15 +0100] Report: jobs=54
D [03/Dec/2011:13:27:15 +0100] Report: jobs-active=1
D [03/Dec/2011:13:27:15 +0100] Report: printers=1
D [03/Dec/2011:13:27:15 +0100] Report: printers-implicit=0
D [03/Dec/2011:13:27:15 +0100] Report: stringpool-string-count=23195
D [03/Dec/2011:13:27:15 +0100] Report: stringpool-alloc-bytes=10896
D [03/Dec/2011:13:27:15 +0100] Report: stringpool-total-bytes=431000
D [03/Dec/2011:13:27:23 +0100] [Job 54] prnt/backend/hp.c 625: ERROR: 5021 device communication error!
D [03/Dec/2011:13:27:23 +0100] PID 4134 (/usr/lib/cups/filter/hpcups) did not catch or ignore signal 13.
D [03/Dec/2011:13:27:23 +0100] PID 4135 (/usr/lib/cups/backend/hp) stopped with status 4!
D [03/Dec/2011:13:27:23 +0100] PID 4133 (/usr/lib/cups/filter/pdftoraster-poppler) did not catch or ignore signal 13.
I [03/Dec/2011:13:27:23 +0100] [Job 54] Backend returned status 4 (stop printer)
D [03/Dec/2011:13:27:23 +0100] Discarding unused job-state-changed event...
I [03/Dec/2011:13:27:23 +0100] [Job 54] Printer stopped due to backend errors; please consult the error_log file for details.
D [03/Dec/2011:13:27:23 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:27:23 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:27:23 +0100] Discarding unused printer-stopped event...
D [03/Dec/2011:13:27:23 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:27:23 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
D [03/Dec/2011:13:27:23 +0100] cupsdMarkDirty(P-----)
I [03/Dec/2011:13:27:54 +0100] Saving printers.conf...
I [03/Dec/2011:13:27:54 +0100] Saving job cache file "/var/cache/cups/job.cache"...
D [03/Dec/2011:13:27:54 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:16 +0100] Report: clients=1
D [03/Dec/2011:13:28:16 +0100] Report: jobs=54
D [03/Dec/2011:13:28:16 +0100] Report: jobs-active=1
D [03/Dec/2011:13:28:16 +0100] Report: printers=1
D [03/Dec/2011:13:28:16 +0100] Report: printers-implicit=0
D [03/Dec/2011:13:28:16 +0100] Report: stringpool-string-count=23196
D [03/Dec/2011:13:28:16 +0100] Report: stringpool-alloc-bytes=10952
D [03/Dec/2011:13:28:16 +0100] Report: stringpool-total-bytes=431032
D [03/Dec/2011:13:28:20 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [03/Dec/2011:13:28:20 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [03/Dec/2011:13:28:20 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:20 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:20 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:20 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:20 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:20 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:20 +0100] cupsdAcceptClient: 17 from localhost (Domain)
D [03/Dec/2011:13:28:20 +0100] cupsdReadClient: 17 POST / HTTP/1.1
D [03/Dec/2011:13:28:20 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:20 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:20 +0100] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:20 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:20 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:20 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:20 +0100] cupsdAcceptClient: 18 from localhost (Domain)
D [03/Dec/2011:13:28:20 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [03/Dec/2011:13:28:20 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:20 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:20 +0100] cupsdReadClient: 18 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:20 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:20 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:20 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:21 +0100] cupsdAcceptClient: 19 from localhost (Domain)
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:21 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:21 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:21 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:21 +0100] cupsdAcceptClient: 20 from localhost (Domain)
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 20 POST / HTTP/1.1
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:21 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 20 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:21 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:21 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:21 +0100] cupsdAcceptClient: 21 from localhost (Domain)
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 21 POST / HTTP/1.1
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:21 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 21 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:21 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:21 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:21 +0100] cupsdAcceptClient: 22 from localhost (Domain)
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 22 POST / HTTP/1.1
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:21 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 22 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:21 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:21 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:21 +0100] cupsdAcceptClient: 23 from localhost (Domain)
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 23 POST / HTTP/1.1
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:21 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:21 +0100] cupsdReadClient: 23 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:21 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:21 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:21 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:22 +0100] cupsdAcceptClient: 24 from localhost (Domain)
D [03/Dec/2011:13:28:22 +0100] cupsdReadClient: 24 POST / HTTP/1.1
D [03/Dec/2011:13:28:22 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:22 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:22 +0100] cupsdReadClient: 24 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:22 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:22 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:22 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:22 +0100] cupsdAcceptClient: 25 from localhost (Domain)
D [03/Dec/2011:13:28:22 +0100] cupsdReadClient: 25 POST / HTTP/1.1
D [03/Dec/2011:13:28:22 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:22 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:22 +0100] cupsdReadClient: 25 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:22 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:22 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:22 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:24 +0100] cupsdAcceptClient: 26 from localhost (Domain)
D [03/Dec/2011:13:28:24 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:28:24 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:24 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:24 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:28:24 +0100] CUPS-Get-Default
D [03/Dec/2011:13:28:24 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:28:24 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:24 +0100] cupsdAcceptClient: 27 from localhost (Domain)
D [03/Dec/2011:13:28:24 +0100] cupsdReadClient: 27 POST / HTTP/1.1
D [03/Dec/2011:13:28:24 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:24 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:24 +0100] cupsdReadClient: 27 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:24 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:24 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:24 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:24 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:28:24 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:24 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:24 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:28:24 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:28:24 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:28:24 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 28 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 28 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 28 1.1 Resume-Printer 1
D [03/Dec/2011:13:28:27 +0100] Resume-Printer ipp://localhost/printers/Photosmart-2570-series
D [03/Dec/2011:13:28:27 +0100] cupsdIsAuthorized: username=""
D [03/Dec/2011:13:28:27 +0100] Returning HTTP Unauthorized for Resume-Printer (ipp://localhost/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSendHeader: 28 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 28 WAITING Closing on EOF
D [03/Dec/2011:13:28:27 +0100] cupsdCloseClient: 28
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 28 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 29 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 28 WAITING Closing on EOF
D [03/Dec/2011:13:28:27 +0100] cupsdCloseClient: 28
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 29 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: Authorized as krzysztof using PeerCred
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 29 1.1 Resume-Printer 1
D [03/Dec/2011:13:28:27 +0100] Resume-Printer ipp://localhost/printers/Photosmart-2570-series
D [03/Dec/2011:13:28:27 +0100] cupsdIsAuthorized: username="krzysztof"
D [03/Dec/2011:13:28:27 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:28:27 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
D [03/Dec/2011:13:28:27 +0100] cupsdMarkDirty(P-----)
I [03/Dec/2011:13:28:27 +0100] Printer "Photosmart-2570-series" started by "krzysztof".
D [03/Dec/2011:13:28:27 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:28:27 +0100] [Job 54] job-sheets=none,none
D [03/Dec/2011:13:28:27 +0100] [Job 54] argv[0]="Photosmart-2570-series"
D [03/Dec/2011:13:28:27 +0100] [Job 54] argv[1]="54"
D [03/Dec/2011:13:28:27 +0100] [Job 54] argv[2]="krzysztof"
D [03/Dec/2011:13:28:27 +0100] [Job 54] argv[3]="geogeo"
D [03/Dec/2011:13:28:27 +0100] [Job 54] argv[4]="1"
D [03/Dec/2011:13:28:27 +0100] [Job 54] argv[5]="Duplex=None InputSlot=Auto OutputMode=Best PageSize=A4 job-uuid=urn:uuid:6e77958c-fb40-3fb4-584b-449c48759b6c job-originating-host-name=localhost time-at-creation=1322915204 time-at-processing=1322915307"
D [03/Dec/2011:13:28:27 +0100] [Job 54] argv[6]="/var/spool/cups/d00054-001"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[8]="HOME=/var/spool/cups/tmp"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[10]="SERVER_ADMIN=root@krzysztof-desktop"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[11]="SOFTWARE=CUPS/1.4.6"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[13]="USER=root"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[16]="IPP_PORT=631"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[17]="CHARSET=utf-8"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[18]="LANG=pl_PL.UTF-8"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[19]="PPD=/etc/cups/ppd/Photosmart-2570-series.ppd"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[20]="RIP_MAX_CACHE=auto"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[21]="CONTENT_TYPE=application/postscript"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[22]="DEVICE_URI=hp:/usb/Photosmart_2570_series?serial=MY68P1116504DY"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[23]="PRINTER_INFO=HP Photosmart 2570 series"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[24]="PRINTER_LOCATION=krzysztof-desktop"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[25]="PRINTER=Photosmart-2570-series"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[26]="CUPS_FILETYPE=document"
D [03/Dec/2011:13:28:27 +0100] [Job 54] envp[27]="FINAL_CONTENT_TYPE=printer/Photosmart-2570-series"
I [03/Dec/2011:13:28:27 +0100] [Job 54] Started filter /usr/lib/cups/filter/pstopdf (PID 4208)
I [03/Dec/2011:13:28:27 +0100] [Job 54] Started filter /usr/lib/cups/filter/pdftopdf (PID 4209)
I [03/Dec/2011:13:28:27 +0100] [Job 54] Started filter /usr/lib/cups/filter/pdftoraster-poppler (PID 4210)
I [03/Dec/2011:13:28:27 +0100] [Job 54] Started filter /usr/lib/cups/filter/hpcups (PID 4211)
I [03/Dec/2011:13:28:27 +0100] [Job 54] Started backend /usr/lib/cups/backend/hp (PID 4212)
D [03/Dec/2011:13:28:27 +0100] Discarding unused job-state-changed event...
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for Resume-Printer (ipp://localhost/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:28:27 +0100] [Job 54] pstopdf 6 args: 54 krzysztof geogeo 1 Duplex=None InputSlot=Auto OutputMode=Best PageSize=A4 job-uuid=urn:uuid:6e77958c-fb40-3fb4-584b-449c48759b6c job-originating-host-name=localhost time-at-creation=1322915204 time-at-processing=1322915307 /var/spool/cups/d00054-001
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 29 WAITING Closing on EOF
D [03/Dec/2011:13:28:27 +0100] cupsdCloseClient: 29
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] [Job 54] PPD: /etc/cups/ppd/Photosmart-2570-series.ppd
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Default
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 29 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 29 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 29 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 30 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 30 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 30 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Default
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 31 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 31 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 31 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:28:27 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 32 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 32 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 32 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Default
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAcceptClient: 33 from localhost (Domain)
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 33 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 33 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:28:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:28:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:28:27 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:28:27 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:28:27 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:28:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:28:27 +0100] [Job 54] Resolution: 
D [03/Dec/2011:13:28:27 +0100] [Job 54] Page size: A4
D [03/Dec/2011:13:28:28 +0100] [Job 54] Width: 595, height: 833, absolute margins: 9, 27, 586, 797
D [03/Dec/2011:13:28:28 +0100] [Job 54] Relative margins: 9, 27, 9, 36
D [03/Dec/2011:13:28:28 +0100] [Job 54] PPD options: -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=833
D [03/Dec/2011:13:28:28 +0100] [Job 54] PostScript to be injected: 
D [03/Dec/2011:13:28:28 +0100] [Job 54] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode                 -dPDFSETTINGS=/printer                 -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=833 -sOutputFile=-  -c .setpdfwrite -f -
D [03/Dec/2011:13:28:29 +0100] PID 4208 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [03/Dec/2011:13:28:29 +0100] [Job 54] mediaBox = [ 0.000000 0.000000 595.000000 833.000000 ]
D [03/Dec/2011:13:28:29 +0100] [Job 54] size = A4
D [03/Dec/2011:13:28:29 +0100] PID 4209 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [03/Dec/2011:13:28:31 +0100] [Job 54] PAGE: 1 1
D [03/Dec/2011:13:28:31 +0100] Discarding unused job-progress event...
D [03/Dec/2011:13:28:31 +0100] [Job 54] STATE: +connecting-to-device
D [03/Dec/2011:13:28:31 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:28:32 +0100] [Job 54] STATE: -connecting-to-device
D [03/Dec/2011:13:28:32 +0100] [Job 54] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [03/Dec/2011:13:28:32 +0100] Discarding unused printer-state-changed event...
I [03/Dec/2011:13:28:58 +0100] Saving printers.conf...
I [03/Dec/2011:13:28:58 +0100] Saving job cache file "/var/cache/cups/job.cache"...
D [03/Dec/2011:13:28:58 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] [Job 54] prnt/backend/hp.c 625: ERROR: 5021 device communication error!
D [03/Dec/2011:13:29:03 +0100] PID 4211 (/usr/lib/cups/filter/hpcups) did not catch or ignore signal 13.
D [03/Dec/2011:13:29:03 +0100] PID 4212 (/usr/lib/cups/backend/hp) stopped with status 4!
D [03/Dec/2011:13:29:03 +0100] cupsdAcceptClient: 34 from localhost (Domain)
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 34 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 34 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:03 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAcceptClient: 35 from localhost (Domain)
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 35 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 35 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:29:03 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAcceptClient: 36 from localhost (Domain)
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 36 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 36 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:03 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAcceptClient: 37 from localhost (Domain)
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 37 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 37 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:03 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Active clients and printing jobs
D [03/Dec/2011:13:29:03 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:03 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:29:03 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:29:03 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs
D [03/Dec/2011:13:29:03 +0100] PID 4210 (/usr/lib/cups/filter/pdftoraster-poppler) did not catch or ignore signal 13.
I [03/Dec/2011:13:29:03 +0100] [Job 54] Backend returned status 4 (stop printer)
D [03/Dec/2011:13:29:03 +0100] Discarding unused job-state-changed event...
I [03/Dec/2011:13:29:03 +0100] [Job 54] Printer stopped due to backend errors; please consult the error_log file for details.
D [03/Dec/2011:13:29:03 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:29:03 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:03 +0100] Discarding unused printer-stopped event...
D [03/Dec/2011:13:29:03 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:29:03 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
D [03/Dec/2011:13:29:03 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:29:26 +0100] Report: clients=22
D [03/Dec/2011:13:29:26 +0100] Report: jobs=54
D [03/Dec/2011:13:29:26 +0100] Report: jobs-active=1
D [03/Dec/2011:13:29:26 +0100] Report: printers=1
D [03/Dec/2011:13:29:26 +0100] Report: printers-implicit=0
D [03/Dec/2011:13:29:26 +0100] Report: stringpool-string-count=23196
D [03/Dec/2011:13:29:26 +0100] Report: stringpool-alloc-bytes=10952
D [03/Dec/2011:13:29:26 +0100] Report: stringpool-total-bytes=431032
I [03/Dec/2011:13:29:34 +0100] Saving printers.conf...
I [03/Dec/2011:13:29:34 +0100] Saving job cache file "/var/cache/cups/job.cache"...
D [03/Dec/2011:13:29:34 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:47 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [03/Dec/2011:13:29:47 +0100] cupsdCloseClient: 14
D [03/Dec/2011:13:29:55 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdAcceptClient: 28 from localhost (Domain)
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 28 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdAcceptClient: 38 from localhost (Domain)
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 38 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 38 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdAcceptClient: 39 from localhost (Domain)
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 39 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 39 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:29:55 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdAcceptClient: 40 from localhost (Domain)
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 40 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 40 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdAcceptClient: 41 from localhost (Domain)
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 41 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 41 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:55 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:55 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:55 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:29:55 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:29:55 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:29:55 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:58 +0100] cupsdAcceptClient: 42 from localhost (Domain)
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 1.1 CUPS-Reject-Jobs 1
D [03/Dec/2011:13:29:58 +0100] CUPS-Reject-Jobs ipp://localhost/printers/Photosmart-2570-series
D [03/Dec/2011:13:29:58 +0100] cupsdIsAuthorized: username=""
D [03/Dec/2011:13:29:58 +0100] Returning HTTP Unauthorized for CUPS-Reject-Jobs (ipp://localhost/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSendHeader: 42 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 WAITING Closing on EOF
D [03/Dec/2011:13:29:58 +0100] cupsdCloseClient: 42
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Not busy
D [03/Dec/2011:13:29:58 +0100] cupsdAcceptClient: 42 from localhost (Domain)
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 WAITING Closing on EOF
D [03/Dec/2011:13:29:58 +0100] cupsdCloseClient: 42
D [03/Dec/2011:13:29:58 +0100] cupsdAcceptClient: 42 from localhost (Domain)
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: Authorized as krzysztof using PeerCred
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 1.1 CUPS-Reject-Jobs 1
D [03/Dec/2011:13:29:58 +0100] CUPS-Reject-Jobs ipp://localhost/printers/Photosmart-2570-series
D [03/Dec/2011:13:29:58 +0100] cupsdIsAuthorized: username="krzysztof"
D [03/Dec/2011:13:29:58 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:29:58 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients and dirty files
I [03/Dec/2011:13:29:58 +0100] Printer "Photosmart-2570-series" rejecting jobs ("krzysztof").
D [03/Dec/2011:13:29:58 +0100] Returning IPP successful-ok for CUPS-Reject-Jobs (ipp://localhost/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 WAITING Closing on EOF
D [03/Dec/2011:13:29:58 +0100] cupsdCloseClient: 42
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:58 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:58 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAcceptClient: 42 from localhost (Domain)
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 POST / HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 42 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:58 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:58 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAcceptClient: 43 from localhost (Domain)
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 43 POST / HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 43 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:58 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:58 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:58 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:58 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAcceptClient: 44 from localhost (Domain)
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 44 POST / HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 44 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:58 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:58 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:58 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:58 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:29:58 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:29:58 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:29:58 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 45 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 1.1 Resume-Printer 1
D [03/Dec/2011:13:29:59 +0100] Resume-Printer ipp://localhost/printers/Photosmart-2570-series
D [03/Dec/2011:13:29:59 +0100] cupsdIsAuthorized: username=""
D [03/Dec/2011:13:29:59 +0100] Returning HTTP Unauthorized for Resume-Printer (ipp://localhost/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSendHeader: 45 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 WAITING Closing on EOF
D [03/Dec/2011:13:29:59 +0100] cupsdCloseClient: 45
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 45 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 WAITING Closing on EOF
D [03/Dec/2011:13:29:59 +0100] cupsdCloseClient: 45
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 45 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 POST /admin/ HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: Authorized as krzysztof using PeerCred
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 1.1 Resume-Printer 1
D [03/Dec/2011:13:29:59 +0100] Resume-Printer ipp://localhost/printers/Photosmart-2570-series
D [03/Dec/2011:13:29:59 +0100] cupsdIsAuthorized: username="krzysztof"
D [03/Dec/2011:13:29:59 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:29:59 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:29:59 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
D [03/Dec/2011:13:29:59 +0100] cupsdMarkDirty(P-----)
I [03/Dec/2011:13:29:59 +0100] Printer "Photosmart-2570-series" started by "krzysztof".
D [03/Dec/2011:13:29:59 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:29:59 +0100] [Job 54] job-sheets=none,none
D [03/Dec/2011:13:29:59 +0100] [Job 54] argv[0]="Photosmart-2570-series"
D [03/Dec/2011:13:29:59 +0100] [Job 54] argv[1]="54"
D [03/Dec/2011:13:29:59 +0100] [Job 54] argv[2]="krzysztof"
D [03/Dec/2011:13:29:59 +0100] [Job 54] argv[3]="geogeo"
D [03/Dec/2011:13:29:59 +0100] [Job 54] argv[4]="1"
D [03/Dec/2011:13:29:59 +0100] [Job 54] argv[5]="Duplex=None InputSlot=Auto OutputMode=Best PageSize=A4 job-uuid=urn:uuid:6e77958c-fb40-3fb4-584b-449c48759b6c job-originating-host-name=localhost time-at-creation=1322915204 time-at-processing=1322915399"
D [03/Dec/2011:13:29:59 +0100] [Job 54] argv[6]="/var/spool/cups/d00054-001"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[8]="HOME=/var/spool/cups/tmp"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[10]="SERVER_ADMIN=root@krzysztof-desktop"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[11]="SOFTWARE=CUPS/1.4.6"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[13]="USER=root"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[16]="IPP_PORT=631"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[17]="CHARSET=utf-8"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[18]="LANG=pl_PL.UTF-8"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[19]="PPD=/etc/cups/ppd/Photosmart-2570-series.ppd"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[20]="RIP_MAX_CACHE=auto"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[21]="CONTENT_TYPE=application/postscript"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[22]="DEVICE_URI=hp:/usb/Photosmart_2570_series?serial=MY68P1116504DY"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[23]="PRINTER_INFO=HP Photosmart 2570 series"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[24]="PRINTER_LOCATION=krzysztof-desktop"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[25]="PRINTER=Photosmart-2570-series"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[26]="CUPS_FILETYPE=document"
D [03/Dec/2011:13:29:59 +0100] [Job 54] envp[27]="FINAL_CONTENT_TYPE=printer/Photosmart-2570-series"
I [03/Dec/2011:13:29:59 +0100] [Job 54] Started filter /usr/lib/cups/filter/pstopdf (PID 4274)
I [03/Dec/2011:13:29:59 +0100] [Job 54] Started filter /usr/lib/cups/filter/pdftopdf (PID 4275)
I [03/Dec/2011:13:29:59 +0100] [Job 54] Started filter /usr/lib/cups/filter/pdftoraster-poppler (PID 4276)
I [03/Dec/2011:13:29:59 +0100] [Job 54] Started filter /usr/lib/cups/filter/hpcups (PID 4277)
I [03/Dec/2011:13:29:59 +0100] [Job 54] Started backend /usr/lib/cups/backend/hp (PID 4278)
D [03/Dec/2011:13:29:59 +0100] Discarding unused job-state-changed event...
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for Resume-Printer (ipp://localhost/printers/Photosmart-2570-series) from localhost
D [03/Dec/2011:13:29:59 +0100] [Job 54] pstopdf 6 args: 54 krzysztof geogeo 1 Duplex=None InputSlot=Auto OutputMode=Best PageSize=A4 job-uuid=urn:uuid:6e77958c-fb40-3fb4-584b-449c48759b6c job-originating-host-name=localhost time-at-creation=1322915204 time-at-processing=1322915399 /var/spool/cups/d00054-001
D [03/Dec/2011:13:29:59 +0100] [Job 54] PPD: /etc/cups/ppd/Photosmart-2570-series.ppd
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 WAITING Closing on EOF
D [03/Dec/2011:13:29:59 +0100] cupsdCloseClient: 45
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 45 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 45 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 47 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 47 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 47 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 48 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 48 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 48 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:29:59 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 49 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 49 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 49 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Default
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAcceptClient: 50 from localhost (Domain)
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 50 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 50 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:29:59 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:29:59 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:29:59 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:29:59 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:29:59 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:29:59 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:29:59 +0100] [Job 54] Resolution: 
D [03/Dec/2011:13:30:00 +0100] [Job 54] Page size: A4
D [03/Dec/2011:13:30:00 +0100] [Job 54] Width: 595, height: 833, absolute margins: 9, 27, 586, 797
D [03/Dec/2011:13:30:00 +0100] [Job 54] Relative margins: 9, 27, 9, 36
D [03/Dec/2011:13:30:00 +0100] [Job 54] PPD options: -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=833
D [03/Dec/2011:13:30:00 +0100] [Job 54] PostScript to be injected: 
D [03/Dec/2011:13:30:00 +0100] [Job 54] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode                 -dPDFSETTINGS=/printer                 -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=833 -sOutputFile=-  -c .setpdfwrite -f -
D [03/Dec/2011:13:30:01 +0100] PID 4274 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [03/Dec/2011:13:30:01 +0100] [Job 54] mediaBox = [ 0.000000 0.000000 595.000000 833.000000 ]
D [03/Dec/2011:13:30:01 +0100] [Job 54] size = A4
D [03/Dec/2011:13:30:01 +0100] PID 4275 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [03/Dec/2011:13:30:04 +0100] [Job 54] PAGE: 1 1
D [03/Dec/2011:13:30:04 +0100] Discarding unused job-progress event...
D [03/Dec/2011:13:30:04 +0100] [Job 54] STATE: +connecting-to-device
D [03/Dec/2011:13:30:04 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:30:04 +0100] [Job 54] STATE: -connecting-to-device
D [03/Dec/2011:13:30:04 +0100] [Job 54] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [03/Dec/2011:13:30:04 +0100] Discarding unused printer-state-changed event...
D [03/Dec/2011:13:30:27 +0100] [Job 54] prnt/backend/hp.c 625: ERROR: 5021 device communication error!
D [03/Dec/2011:13:30:27 +0100] Report: clients=35
D [03/Dec/2011:13:30:27 +0100] Report: jobs=54
D [03/Dec/2011:13:30:27 +0100] Report: jobs-active=1
D [03/Dec/2011:13:30:27 +0100] Report: printers=1
D [03/Dec/2011:13:30:27 +0100] Report: printers-implicit=0
D [03/Dec/2011:13:30:27 +0100] Report: stringpool-string-count=23195
D [03/Dec/2011:13:30:27 +0100] Report: stringpool-alloc-bytes=10896
D [03/Dec/2011:13:30:27 +0100] Report: stringpool-total-bytes=431000
D [03/Dec/2011:13:30:27 +0100] PID 4277 (/usr/lib/cups/filter/hpcups) did not catch or ignore signal 13.
D [03/Dec/2011:13:30:27 +0100] PID 4278 (/usr/lib/cups/backend/hp) stopped with status 4!
D [03/Dec/2011:13:30:27 +0100] cupsdAcceptClient: 51 from localhost (Domain)
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 51 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 51 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:30:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:30:27 +0100] CUPS-Get-Default
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAcceptClient: 52 from localhost (Domain)
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 52 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 52 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:30:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:30:27 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAcceptClient: 53 from localhost (Domain)
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 53 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 53 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:30:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 1.1 CUPS-Get-Default 1
D [03/Dec/2011:13:30:27 +0100] CUPS-Get-Default
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAcceptClient: 54 from localhost (Domain)
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 54 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 54 1.1 CUPS-Get-Printers 1
D [03/Dec/2011:13:30:27 +0100] CUPS-Get-Printers
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 POST / HTTP/1.1
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [03/Dec/2011:13:30:27 +0100] cupsdAuthorize: No authentication data provided.
D [03/Dec/2011:13:30:27 +0100] cupsdReadClient: 26 1.1 Get-Jobs 1
D [03/Dec/2011:13:30:27 +0100] Get-Jobs ipp://localhost/
D [03/Dec/2011:13:30:27 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [03/Dec/2011:13:30:27 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [03/Dec/2011:13:30:27 +0100] PID 4276 (/usr/lib/cups/filter/pdftoraster-poppler) did not catch or ignore signal 13.
I [03/Dec/2011:13:30:27 +0100] [Job 54] Backend returned status 4 (stop printer)
D [03/Dec/2011:13:30:27 +0100] Discarding unused job-state-changed event...
I [03/Dec/2011:13:30:27 +0100] [Job 54] Printer stopped due to backend errors; please consult the error_log file for details.
D [03/Dec/2011:13:30:27 +0100] cupsdMarkDirty(----J-)
D [03/Dec/2011:13:30:27 +0100] Discarding unused printer-stopped event...
D [03/Dec/2011:13:30:27 +0100] cupsdMarkDirty(P-----)
D [03/Dec/2011:13:30:27 +0100] cupsdRegisterPrinter(p=0x21cbdde8(Photosmart-2570-series))
D [03/Dec/2011:13:30:27 +0100] cupsdMarkDirty(P-----)
I [03/Dec/2011:13:30:28 +0100] Saving printers.conf...
I [03/Dec/2011:13:30:28 +0100] Saving job cache file "/var/cache/cups/job.cache"...
D [03/Dec/2011:13:30:28 +0100] cupsdSetBusyState: Not busy