I [14/May/2009:18:56:29 +0200] Listening to ::1:631 (IPv6)
I [14/May/2009:18:56:29 +0200] Listening to 127.0.0.1:631 (IPv4)
I [14/May/2009:18:56:29 +0200] Listening to /var/run/cups/cups.sock (Domain)
I [14/May/2009:18:56:29 +0200] Loaded configuration file "/etc/cups/cupsd.conf"
I [14/May/2009:18:56:29 +0200] Using default TempDir of /var/spool/cups/tmp...
I [14/May/2009:18:56:29 +0200] Configured for up to 100 clients.
I [14/May/2009:18:56:29 +0200] Allowing up to 100 client connections per host.
I [14/May/2009:18:56:29 +0200] Using policy "default" as the default!
I [14/May/2009:18:56:29 +0200] Full reload is required.
I [14/May/2009:18:56:29 +0200] Saving job cache file "/var/cache/cups/job.cache"...
D [14/May/2009:18:56:29 +0200] Discarding unused printer-stopped event...
D [14/May/2009:18:56:29 +0200] Discarding unused printer-stopped event...
D [14/May/2009:18:56:29 +0200] Discarding unused printer-stopped event...
I [14/May/2009:18:56:29 +0200] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 37 types, 65 filters...
D [14/May/2009:18:56:29 +0200] Loading printer HL-5040-series...
D [14/May/2009:18:56:29 +0200] Loading printer magicolor-2530-DL-do-not-use...
D [14/May/2009:18:56:29 +0200] Loading printer magicolor-2530-DL-ipp...
D [14/May/2009:18:56:29 +0200] cupsdLoadRemoteCache: Not loading remote cache.
I [14/May/2009:18:56:29 +0200] Loading job cache file "/var/cache/cups/job.cache"...
D [14/May/2009:18:56:29 +0200] [Job 2] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 3] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 12] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 16] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 20] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 22] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 23] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 24] Loading from cache...
D [14/May/2009:18:56:29 +0200] [Job 25] Loading from cache...
I [14/May/2009:18:56:29 +0200] Full reload complete.
I [14/May/2009:18:56:29 +0200] Listening to ::1:631 on fd 4...
I [14/May/2009:18:56:29 +0200] Listening to 127.0.0.1:631 on fd 5...
I [14/May/2009:18:56:29 +0200] Listening to /var/run/cups/cups.sock on fd 6...
I [14/May/2009:18:56:29 +0200] Resuming new connection processing...
D [14/May/2009:18:56:29 +0200] Discarding unused server-restarted event...
D [14/May/2009:18:56:32 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:32 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:32 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:32 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:56:32 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:56:32 +0200] CUPS-Get-Printers
D [14/May/2009:18:56:32 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:56:32 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:35 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:35 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:35 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:35 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:56:35 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:56:35 +0200] CUPS-Get-Printers
D [14/May/2009:18:56:35 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:56:35 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:38 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:38 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:38 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:38 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:56:38 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:56:38 +0200] CUPS-Get-Printers
D [14/May/2009:18:56:38 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:56:38 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:41 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:41 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:18:56:41 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:41 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:56:41 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:56:41 +0200] CUPS-Get-Printers
D [14/May/2009:18:56:41 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:56:41 +0200] cupsdCloseClient: 11
D [14/May/2009:18:56:42 +0200] Report: clients=0
D [14/May/2009:18:56:42 +0200] Report: jobs=9
D [14/May/2009:18:56:42 +0200] Report: jobs-active=0
D [14/May/2009:18:56:42 +0200] Report: printers=3
D [14/May/2009:18:56:42 +0200] Report: printers-implicit=0
D [14/May/2009:18:56:42 +0200] Report: stringpool-string-count=584
D [14/May/2009:18:56:42 +0200] Report: stringpool-alloc-bytes=7912
D [14/May/2009:18:56:42 +0200] Report: stringpool-total-bytes=11968
D [14/May/2009:18:56:44 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:44 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:18:56:44 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:44 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:56:44 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:56:44 +0200] CUPS-Get-Printers
D [14/May/2009:18:56:44 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:56:45 +0200] cupsdCloseClient: 11
D [14/May/2009:18:56:47 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:47 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:18:56:47 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:47 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:56:47 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:56:47 +0200] CUPS-Get-Printers
D [14/May/2009:18:56:47 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:56:47 +0200] cupsdCloseClient: 11
D [14/May/2009:18:56:50 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:56:50 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:18:56:50 +0200] cupsdCloseClient: 9
D [14/May/2009:18:56:50 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:56:50 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:56:50 +0200] CUPS-Get-Printers
D [14/May/2009:18:56:50 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:56:50 +0200] cupsdCloseClient: 11
D [14/May/2009:18:57:03 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:57:04 +0200] cupsdReadClient: 9 POST /printers/magicolor-2530-DL-do-not-use HTTP/1.1
D [14/May/2009:18:57:04 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:57:05 +0200] Print-Job ipp://localhost:631/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:18:57:05 +0200] [Job ???] Auto-typing file...
I [14/May/2009:18:57:05 +0200] [Job ???] Request file type is application/pdf.
D [14/May/2009:18:57:05 +0200] Print-Job server-error-not-accepting-jobs: Destination "magicolor-2530-DL-do-not-use" is not accepting jobs.
D [14/May/2009:18:57:05 +0200] cupsdProcessIPPRequest: 9 status_code=506 (server-error-not-accepting-jobs)
D [14/May/2009:18:57:05 +0200] cupsdCloseClient: 9
D [14/May/2009:18:58:07 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:18:58:07 +0200] Report: clients=1
D [14/May/2009:18:58:07 +0200] Report: jobs=9
D [14/May/2009:18:58:07 +0200] Report: jobs-active=0
D [14/May/2009:18:58:07 +0200] Report: printers=3
D [14/May/2009:18:58:07 +0200] Report: printers-implicit=0
D [14/May/2009:18:58:07 +0200] Report: stringpool-string-count=584
D [14/May/2009:18:58:07 +0200] Report: stringpool-alloc-bytes=7912
D [14/May/2009:18:58:07 +0200] Report: stringpool-total-bytes=11968
D [14/May/2009:18:58:07 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:18:58:08 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:58:08 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:08 +0200] Create-Printer-Subscription /
D [14/May/2009:18:58:08 +0200] cupsdCreateSubscription(con=0xb9636f58(11), uri="/")
D [14/May/2009:18:58:08 +0200] pullmethod="ippget"
D [14/May/2009:18:58:08 +0200] notify-lease-duration=86400
D [14/May/2009:18:58:08 +0200] notify-time-interval=0
D [14/May/2009:18:58:08 +0200] cupsdAddSubscription(mask=18f, dest=(nil)(), job=(nil)(0), uri="(null)")
D [14/May/2009:18:58:08 +0200] Added subscription 21 for server
I [14/May/2009:18:58:08 +0200] Saving subscriptions.conf...
D [14/May/2009:18:58:08 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:58:08 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:58:08 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:08 +0200] CUPS-Get-Printers
D [14/May/2009:18:58:08 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:58:08 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:58:08 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:08 +0200] CUPS-Get-Printers
D [14/May/2009:18:58:08 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:58:08 +0200] cupsdCloseClient: 11
D [14/May/2009:18:58:08 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:58:08 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:08 +0200] CUPS-Get-Printers
D [14/May/2009:18:58:08 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:58:08 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:58:08 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:08 +0200] CUPS-Get-Classes
D [14/May/2009:18:58:08 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:58:08 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:58:08 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:08 +0200] CUPS-Get-Default
D [14/May/2009:18:58:08 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:58:09 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:18:58:09 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:58:09 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:09 +0200] Get-Notifications /
D [14/May/2009:18:58:09 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:18:58:09 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:58:09 +0200] cupsdCloseClient: 11
D [14/May/2009:18:58:19 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:58:19 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:19 +0200] Get-Printer-Attributes ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:18:58:19 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:58:19 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:18:58:19 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:58:19 +0200] Get-Printer-Attributes ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:18:58:19 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:18:58:19 +0200] cupsdReadClient: 9 GET /printers/magicolor-2530-DL-do-not-use.ppd HTTP/1.1
D [14/May/2009:18:58:19 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:59:09 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:18:59:09 +0200] Report: clients=2
D [14/May/2009:18:59:09 +0200] Report: jobs=9
D [14/May/2009:18:59:09 +0200] Report: jobs-active=0
D [14/May/2009:18:59:09 +0200] Report: printers=3
D [14/May/2009:18:59:09 +0200] Report: printers-implicit=0
D [14/May/2009:18:59:09 +0200] Report: stringpool-string-count=585
D [14/May/2009:18:59:09 +0200] Report: stringpool-alloc-bytes=7912
D [14/May/2009:18:59:09 +0200] Report: stringpool-total-bytes=11976
D [14/May/2009:18:59:09 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:59:09 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:59:09 +0200] Get-Notifications /
D [14/May/2009:18:59:09 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:18:59:09 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:59:09 +0200] cupsdCloseClient: 11
D [14/May/2009:18:59:58 +0200] cupsdAcceptClient: 11 from localhost:631 (IPv6)
D [14/May/2009:18:59:58 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:59:58 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:59:58 +0200] CUPS-Get-Printers
D [14/May/2009:18:59:58 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:59:58 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:59:58 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:59:58 +0200] CUPS-Get-Classes
D [14/May/2009:18:59:58 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:18:59:58 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:18:59:58 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:18:59:58 +0200] CUPS-Get-Default
D [14/May/2009:18:59:58 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:09 +0200] cupsdAcceptClient: 12 from localhost (Domain)
D [14/May/2009:19:00:09 +0200] Report: clients=3
D [14/May/2009:19:00:09 +0200] Report: jobs=9
D [14/May/2009:19:00:09 +0200] Report: jobs-active=0
D [14/May/2009:19:00:09 +0200] Report: printers=3
D [14/May/2009:19:00:09 +0200] Report: printers-implicit=0
D [14/May/2009:19:00:09 +0200] Report: stringpool-string-count=585
D [14/May/2009:19:00:09 +0200] Report: stringpool-alloc-bytes=7912
D [14/May/2009:19:00:09 +0200] Report: stringpool-total-bytes=11976
D [14/May/2009:19:00:09 +0200] cupsdReadClient: 12 POST / HTTP/1.1
D [14/May/2009:19:00:09 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:09 +0200] Get-Notifications /
D [14/May/2009:19:00:09 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:00:09 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [14/May/2009:19:00:09 +0200] cupsdCloseClient: 12
D [14/May/2009:19:00:12 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:12 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:12 +0200] Get-Printer-Attributes ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:00:12 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:12 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:12 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:12 +0200] Get-Printer-Attributes ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:00:12 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:12 +0200] cupsdAcceptClient: 12 from localhost:631 (IPv6)
D [14/May/2009:19:00:12 +0200] cupsdReadClient: 12 GET /printers/magicolor-2530-DL-do-not-use.ppd HTTP/1.1
D [14/May/2009:19:00:12 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:12 +0200] cupsdCloseClient: 12
D [14/May/2009:19:00:19 +0200] cupsdReadClient: 11 POST /admin/ HTTP/1.1
D [14/May/2009:19:00:19 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:19 +0200] CUPS-Accept-Jobs ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:00:19 +0200] cupsdIsAuthorized: username=""
E [14/May/2009:19:00:19 +0200] CUPS-Accept-Jobs: Unauthorized
D [14/May/2009:19:00:19 +0200] cupsdSendError: 11 code=401 (Unauthorized)
D [14/May/2009:19:00:19 +0200] cupsdSendHeader: WWW-Authenticate: Basic realm="CUPS"
D [14/May/2009:19:00:19 +0200] cupsdCloseClient: 11
D [14/May/2009:19:00:19 +0200] cupsdAcceptClient: 11 from localhost:631 (IPv6)
D [14/May/2009:19:00:19 +0200] cupsdReadClient: 11 POST /admin/ HTTP/1.1
D [14/May/2009:19:00:19 +0200] cupsdAuthorize: Authorized as root using Local
D [14/May/2009:19:00:19 +0200] CUPS-Accept-Jobs ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:00:19 +0200] cupsdIsAuthorized: username="root"
I [14/May/2009:19:00:19 +0200] Saving printers.conf...
I [14/May/2009:19:00:19 +0200] Printer "magicolor-2530-DL-do-not-use" now accepting jobs ("root").
D [14/May/2009:19:00:19 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:19 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:19 +0200] cupsdAuthorize: Authorized as root using Local
D [14/May/2009:19:00:19 +0200] CUPS-Get-Printers
D [14/May/2009:19:00:19 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:19 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:19 +0200] cupsdAuthorize: Authorized as root using Local
D [14/May/2009:19:00:19 +0200] CUPS-Get-Classes
D [14/May/2009:19:00:19 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:19 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:19 +0200] cupsdAuthorize: Authorized as root using Local
D [14/May/2009:19:00:19 +0200] Get-Printer-Attributes ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:00:19 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:19 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:19 +0200] cupsdAuthorize: Authorized as root using Local
D [14/May/2009:19:00:19 +0200] Get-Printer-Attributes ipp://localhost/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:00:19 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:19 +0200] cupsdAcceptClient: 12 from localhost:631 (IPv6)
D [14/May/2009:19:00:19 +0200] cupsdReadClient: 12 GET /printers/magicolor-2530-DL-do-not-use.ppd HTTP/1.1
D [14/May/2009:19:00:19 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:19 +0200] cupsdCloseClient: 12
D [14/May/2009:19:00:22 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:22 +0200] cupsdAuthorize: Authorized as root using Local
D [14/May/2009:19:00:22 +0200] CUPS-Get-Printers
D [14/May/2009:19:00:22 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:22 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:22 +0200] cupsdAuthorize: Authorized as root using Local
D [14/May/2009:19:00:22 +0200] CUPS-Get-Classes
D [14/May/2009:19:00:22 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:24 +0200] cupsdAcceptClient: 12 from localhost (Domain)
D [14/May/2009:19:00:24 +0200] cupsdReadClient: 12 POST / HTTP/1.1
D [14/May/2009:19:00:24 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:24 +0200] Cancel-Subscription /
D [14/May/2009:19:00:24 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
I [14/May/2009:19:00:24 +0200] Saving subscriptions.conf...
D [14/May/2009:19:00:24 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [14/May/2009:19:00:24 +0200] cupsdCloseClient: 12
D [14/May/2009:19:00:24 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:25 +0200] cupsdCloseClient: 11
D [14/May/2009:19:00:32 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:32 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:00:32 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:33 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:33 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:33 +0200] CUPS-Get-Printers
D [14/May/2009:19:00:33 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:33 +0200] cupsdCloseClient: 11
D [14/May/2009:19:00:33 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:33 +0200] cupsdReadClient: 9 GET /printers/HL-5040-series.ppd HTTP/1.1
D [14/May/2009:19:00:33 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:33 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:35 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:35 +0200] cupsdReadClient: 9 GET /printers/magicolor-2530-DL-do-not-use.ppd HTTP/1.1
D [14/May/2009:19:00:35 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:35 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:35 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:35 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:35 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:35 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:00:35 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:35 +0200] CUPS-Get-Printers
D [14/May/2009:19:00:35 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:00:35 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:38 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:38 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:38 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:38 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:00:38 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:38 +0200] CUPS-Get-Printers
D [14/May/2009:19:00:38 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:00:38 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:41 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:41 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:41 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:41 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:00:41 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:41 +0200] CUPS-Get-Printers
D [14/May/2009:19:00:41 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:00:41 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:44 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:00:44 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:00:44 +0200] cupsdCloseClient: 9
D [14/May/2009:19:00:44 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:00:44 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:00:44 +0200] CUPS-Get-Printers
D [14/May/2009:19:00:44 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:00:44 +0200] cupsdCloseClient: 11
D [14/May/2009:19:01:00 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:01:01 +0200] cupsdReadClient: 9 POST /printers/magicolor-2530-DL-do-not-use HTTP/1.1
D [14/May/2009:19:01:01 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:01 +0200] Print-Job ipp://localhost:631/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:01:01 +0200] [Job ???] Auto-typing file...
I [14/May/2009:19:01:01 +0200] [Job ???] Request file type is application/pdf.
D [14/May/2009:19:01:01 +0200] add_job: requesting-user-name="laurent"
I [14/May/2009:19:01:01 +0200] [Job 44] Adding start banner page "none".
D [14/May/2009:19:01:01 +0200] Discarding unused job-created event...
I [14/May/2009:19:01:01 +0200] [Job 44] Adding end banner page "none".
I [14/May/2009:19:01:01 +0200] [Job 44] File of type application/pdf queued by "laurent".
D [14/May/2009:19:01:01 +0200] [Job 44] hold_until=0
I [14/May/2009:19:01:01 +0200] [Job 44] Queued on "magicolor-2530-DL-do-not-use" by "laurent".
D [14/May/2009:19:01:01 +0200] Discarding unused printer-state-changed event...
D [14/May/2009:19:01:01 +0200] [Job 44] job-sheets=none,none
D [14/May/2009:19:01:01 +0200] [Job 44] banner_page = 0
D [14/May/2009:19:01:01 +0200] [Job 44] argv[0]="magicolor-2530-DL-do-not-use"
D [14/May/2009:19:01:01 +0200] [Job 44] argv[1]="44"
D [14/May/2009:19:01:01 +0200] [Job 44] argv[2]="laurent"
D [14/May/2009:19:01:01 +0200] [Job 44] argv[3]="out.pnm"
D [14/May/2009:19:01:01 +0200] [Job 44] argv[4]="1"
D [14/May/2009:19:01:01 +0200] [Job 44] argv[5]="Resolution=600x600dpi Quality=normal MediaType=plain NupOrient=port ColorMode=ICM PageSize=A4 Nup=1up number-up=1 ICM=km2530-jc Duplex=None InputSlot=Auto job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d"
D [14/May/2009:19:01:01 +0200] [Job 44] argv[6]="/var/spool/cups/d00044-001"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[9]="SERVER_ADMIN=root@boromir"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[10]="SOFTWARE=CUPS/1.3.9"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[12]="TZ=Europe/Paris"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[13]="USER=root"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[16]="IPP_PORT=631"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[17]="CHARSET=utf-8"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[18]="LANG=fr_FR.UTF8"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[19]="PPD=/etc/cups/ppd/magicolor-2530-DL-do-not-use.ppd"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[20]="RIP_MAX_CACHE=8m"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[21]="CONTENT_TYPE=application/pdf"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[22]="DEVICE_URI=socket://192.168.1.117:9100"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[23]="PRINTER=magicolor-2530-DL-do-not-use"
D [14/May/2009:19:01:01 +0200] [Job 44] envp[24]="FINAL_CONTENT_TYPE=printer/magicolor-2530-DL-do-not-use"
I [14/May/2009:19:01:01 +0200] [Job 44] Started filter /usr/lib/cups/filter/pdftopdf (PID 4576)
I [14/May/2009:19:01:01 +0200] [Job 44] Started filter /usr/lib/cups/filter/foomatic-rip (PID 4577)
I [14/May/2009:19:01:01 +0200] [Job 44] Started backend /usr/lib/cups/backend/socket (PID 4578)
D [14/May/2009:19:01:01 +0200] Discarding unused job-state-changed event...
D [14/May/2009:19:01:01 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:01 +0200] cupsdCloseClient: 9
D [14/May/2009:19:01:01 +0200] Discarding unused printer-state-changed event...
D [14/May/2009:19:01:01 +0200] [Job 44] Connected to 192.168.1.117:9100 (IPv4)...
D [14/May/2009:19:01:01 +0200] [Job 44] backendRunLoop(print_fd=0, device_fd=5, use_bc=1, side_cb=0xb80e2fc0)
D [14/May/2009:19:01:01 +0200] Discarding unused printer-state-changed event...
D [14/May/2009:19:01:01 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:01:01 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:01:01 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:01 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:01:01 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:01 +0200] cupsdCloseClient: 9
D [14/May/2009:19:01:02 +0200] [Job 44] Getting input from file 
D [14/May/2009:19:01:02 +0200] [Job 44] foomatic-rip version 4.0.0.195 running...
D [14/May/2009:19:01:02 +0200] [Job 44] Parsing PPD file ...
D [14/May/2009:19:01:02 +0200] [Job 44] Added option PageSize
D [14/May/2009:19:01:02 +0200] [Job 44] Added option Quality
D [14/May/2009:19:01:02 +0200] [Job 44] Added option PrinterType
D [14/May/2009:19:01:02 +0200] [Job 44] Added option ColorMode
D [14/May/2009:19:01:02 +0200] [Job 44] Added option Resolution
D [14/May/2009:19:01:02 +0200] [Job 44] Added option ImageableArea
D [14/May/2009:19:01:02 +0200] [Job 44] Added option PaperDimension
D [14/May/2009:19:01:02 +0200] [Job 44] Added option InputSlot
D [14/May/2009:19:01:02 +0200] [Job 44] Added option MediaType
D [14/May/2009:19:01:02 +0200] [Job 44] Added option Duplex
D [14/May/2009:19:01:02 +0200] [Job 44] Added option Copies
D [14/May/2009:19:01:02 +0200] [Job 44] Added option ICM
D [14/May/2009:19:01:02 +0200] [Job 44] Added option Nup
D [14/May/2009:19:01:02 +0200] [Job 44] Added option NupOrient
D [14/May/2009:19:01:02 +0200] [Job 44] Added option Font
D [14/May/2009:19:01:02 +0200] [Job 44] 
D [14/May/2009:19:01:02 +0200] [Job 44] Parameter Summary
D [14/May/2009:19:01:02 +0200] [Job 44] -----------------
D [14/May/2009:19:01:02 +0200] [Job 44] 
D [14/May/2009:19:01:02 +0200] [Job 44] Spooler: cups
D [14/May/2009:19:01:02 +0200] [Job 44] Printer: magicolor-2530-DL-do-not-use
D [14/May/2009:19:01:02 +0200] [Job 44] Shell: /bin/bash
D [14/May/2009:19:01:02 +0200] [Job 44] PPD file: /etc/cups/ppd/magicolor-2530-DL-do-not-use.ppd
D [14/May/2009:19:01:02 +0200] [Job 44] ATTR file: 
D [14/May/2009:19:01:02 +0200] [Job 44] Printer model: KONICA MINOLTA magicolor 2530 DL Foomatic/foo2lava (recommended)
D [14/May/2009:19:01:02 +0200] [Job 44] Job title: out.pnm
D [14/May/2009:19:01:02 +0200] [Job 44] File(s) to be printed:
D [14/May/2009:19:01:02 +0200] [Job 44] <STDIN>
D [14/May/2009:19:01:02 +0200] [Job 44] 
D [14/May/2009:19:01:02 +0200] [Job 44] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [14/May/2009:19:01:02 +0200] [Job 44] Printing system options:
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'number-up=1'
D [14/May/2009:19:01:02 +0200] [Job 44] Unknown option number-up=1.
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d'
D [14/May/2009:19:01:02 +0200] [Job 44] Unknown option job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d.
D [14/May/2009:19:01:02 +0200] [Job 44] Options from the PPD file:
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'Resolution=600x600dpi'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'Quality=normal'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'MediaType=plain'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'NupOrient=port'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'ColorMode=ICM'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'PageSize=A4'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'Nup=1up'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'ICM=km2530-jc'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'Duplex=None'
D [14/May/2009:19:01:02 +0200] [Job 44] Pondering option 'InputSlot=Auto'
D [14/May/2009:19:01:02 +0200] [Job 44] 
D [14/May/2009:19:01:02 +0200] [Job 44] ================================================
D [14/May/2009:19:01:02 +0200] [Job 44] 
D [14/May/2009:19:01:02 +0200] [Job 44] File: <STDIN>
D [14/May/2009:19:01:02 +0200] [Job 44] 
D [14/May/2009:19:01:02 +0200] [Job 44] ================================================
D [14/May/2009:19:01:02 +0200] [Job 44] 
D [14/May/2009:19:01:02 +0200] [Job 44] Filetype: PDF
D [14/May/2009:19:01:02 +0200] [Job 44] Driver does not understand PDF input, converting to PostScript
D [14/May/2009:19:01:02 +0200] [Job 44] Starting process "pdf-to-ps" (generation 1)
D [14/May/2009:19:01:04 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:01:04 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:01:04 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:04 +0200] Create-Printer-Subscription /
D [14/May/2009:19:01:04 +0200] cupsdCreateSubscription(con=0xb9601a00(9), uri="/")
D [14/May/2009:19:01:04 +0200] pullmethod="ippget"
D [14/May/2009:19:01:04 +0200] notify-lease-duration=86400
D [14/May/2009:19:01:04 +0200] notify-time-interval=0
D [14/May/2009:19:01:04 +0200] cupsdAddSubscription(mask=798f, dest=(nil)(), job=(nil)(0), uri="(null)")
D [14/May/2009:19:01:04 +0200] Added subscription 22 for server
I [14/May/2009:19:01:04 +0200] Saving subscriptions.conf...
D [14/May/2009:19:01:04 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:04 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:01:04 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:04 +0200] CUPS-Get-Printers
D [14/May/2009:19:01:04 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:04 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:01:04 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:04 +0200] CUPS-Get-Printers
D [14/May/2009:19:01:04 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:04 +0200] cupsdCloseClient: 9
D [14/May/2009:19:01:04 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:01:04 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:01:04 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:04 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:01:04 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:04 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:01:04 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:01:04 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:04 +0200] Get-Printer-Attributes ipp://boromir:631/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:01:04 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:01:04 +0200] cupsdCloseClient: 11
D [14/May/2009:19:01:04 +0200] cupsdCloseClient: 9
D [14/May/2009:19:01:04 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:01:04 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:01:04 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:04 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:01:04 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:04 +0200] cupsdCloseClient: 9
D [14/May/2009:19:01:05 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:01:05 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:01:05 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:01:05 +0200] Get-Notifications /
D [14/May/2009:19:01:05 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:01:05 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:01:05 +0200] cupsdCloseClient: 9
D [14/May/2009:19:01:17 +0200] Report: clients=0
D [14/May/2009:19:01:17 +0200] Report: jobs=10
D [14/May/2009:19:01:17 +0200] Report: jobs-active=1
D [14/May/2009:19:01:17 +0200] Report: printers=3
D [14/May/2009:19:01:17 +0200] Report: printers-implicit=0
D [14/May/2009:19:01:17 +0200] Report: stringpool-string-count=699
D [14/May/2009:19:01:17 +0200] Report: stringpool-alloc-bytes=9216
D [14/May/2009:19:01:17 +0200] Report: stringpool-total-bytes=14464
D [14/May/2009:19:01:17 +0200] PID 4576 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [14/May/2009:19:01:18 +0200] [Job 44] Filetype: PostScript
D [14/May/2009:19:01:18 +0200] [Job 44] Reading PostScript input ...
D [14/May/2009:19:01:18 +0200] [Job 44] --> This document is DSC-conforming!
D [14/May/2009:19:01:18 +0200] [Job 44] 
D [14/May/2009:19:01:18 +0200] [Job 44] -----------
D [14/May/2009:19:01:18 +0200] [Job 44] Found: %%BeginProlog
D [14/May/2009:19:01:18 +0200] [Job 44] Inserting option code into "Prolog" section.
D [14/May/2009:19:01:18 +0200] [Job 44] Found: %%EndProlog
D [14/May/2009:19:01:18 +0200] [Job 44] 
D [14/May/2009:19:01:18 +0200] [Job 44] -----------
D [14/May/2009:19:01:18 +0200] [Job 44] New page: %%Page: 1 1
D [14/May/2009:19:01:18 +0200] [Job 44] "Setup" section is missing, inserting it.
D [14/May/2009:19:01:18 +0200] [Job 44] Inserting PostScript code for CUPS' page accounting
D [14/May/2009:19:01:18 +0200] [Job 44] Inserting option code into "Setup" section.
D [14/May/2009:19:01:18 +0200] [Job 44] No page header or page header not DSC-conforming
D [14/May/2009:19:01:18 +0200] [Job 44] "PageSetup" section is missing, inserting it.
D [14/May/2009:19:01:18 +0200] [Job 44] Inserting option code into "PageSetup" section.
D [14/May/2009:19:01:18 +0200] [Job 44] Stopping search for page header options
D [14/May/2009:19:01:18 +0200] [Job 44] Found: 451 7775 5 3 rf
D [14/May/2009:19:01:18 +0200] [Job 44] --> Output goes directly to the renderer now.
D [14/May/2009:19:01:18 +0200] [Job 44] 
D [14/May/2009:19:01:18 +0200] [Job 44] 
D [14/May/2009:19:01:18 +0200] [Job 44] Starting renderer with command: "foo2lava-wrapper -z0   -c -C10 -r600x600 -p26 -m0 -s255   -d1 -Gkm2530-jconner-d50.icm "
D [14/May/2009:19:01:18 +0200] [Job 44] Starting process "kid3" (generation 1)
D [14/May/2009:19:01:18 +0200] [Job 44] Starting process "kid4" (generation 2)
D [14/May/2009:19:01:18 +0200] [Job 44] JCL: %-12345X@PJL
D [14/May/2009:19:01:18 +0200] [Job 44] <job data> 
D [14/May/2009:19:01:18 +0200] [Job 44] 
D [14/May/2009:19:01:18 +0200] [Job 44] Starting process "renderer" (generation 2)
D [14/May/2009:19:01:19 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:01:19 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:01:19 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:01:20 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:02:05 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:02:05 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:02:05 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:02:05 +0200] Get-Notifications /
D [14/May/2009:19:02:05 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:02:05 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:02:05 +0200] cupsdCloseClient: 9
D [14/May/2009:19:02:17 +0200] Report: clients=0
D [14/May/2009:19:02:17 +0200] Report: jobs=10
D [14/May/2009:19:02:17 +0200] Report: jobs-active=1
D [14/May/2009:19:02:17 +0200] Report: printers=3
D [14/May/2009:19:02:17 +0200] Report: printers-implicit=0
D [14/May/2009:19:02:17 +0200] Report: stringpool-string-count=699
D [14/May/2009:19:02:17 +0200] Report: stringpool-alloc-bytes=9216
D [14/May/2009:19:02:17 +0200] Report: stringpool-total-bytes=14464
D [14/May/2009:19:03:05 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:03:05 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:03:05 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:03:05 +0200] Get-Notifications /
D [14/May/2009:19:03:05 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:03:05 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:03:05 +0200] cupsdCloseClient: 9
D [14/May/2009:19:03:17 +0200] Report: clients=0
D [14/May/2009:19:03:17 +0200] Report: jobs=10
D [14/May/2009:19:03:17 +0200] Report: jobs-active=1
D [14/May/2009:19:03:17 +0200] Report: printers=3
D [14/May/2009:19:03:17 +0200] Report: printers-implicit=0
D [14/May/2009:19:03:17 +0200] Report: stringpool-string-count=699
D [14/May/2009:19:03:17 +0200] Report: stringpool-alloc-bytes=9216
D [14/May/2009:19:03:17 +0200] Report: stringpool-total-bytes=14464
D [14/May/2009:19:04:05 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:04:05 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:04:05 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:04:05 +0200] Get-Notifications /
D [14/May/2009:19:04:05 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:04:05 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:04:05 +0200] cupsdCloseClient: 9
D [14/May/2009:19:04:17 +0200] Report: clients=0
D [14/May/2009:19:04:17 +0200] Report: jobs=10
D [14/May/2009:19:04:17 +0200] Report: jobs-active=1
D [14/May/2009:19:04:17 +0200] Report: printers=3
D [14/May/2009:19:04:17 +0200] Report: printers-implicit=0
D [14/May/2009:19:04:17 +0200] Report: stringpool-string-count=699
D [14/May/2009:19:04:17 +0200] Report: stringpool-alloc-bytes=9216
D [14/May/2009:19:04:17 +0200] Report: stringpool-total-bytes=14464
D [14/May/2009:19:05:05 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:05:05 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:05:05 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:05:05 +0200] Get-Notifications /
D [14/May/2009:19:05:05 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:05:05 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:05:05 +0200] cupsdCloseClient: 9
D [14/May/2009:19:05:17 +0200] Report: clients=0
D [14/May/2009:19:05:17 +0200] Report: jobs=10
D [14/May/2009:19:05:17 +0200] Report: jobs-active=1
D [14/May/2009:19:05:17 +0200] Report: printers=3
D [14/May/2009:19:05:17 +0200] Report: printers-implicit=0
D [14/May/2009:19:05:17 +0200] Report: stringpool-string-count=699
D [14/May/2009:19:05:17 +0200] Report: stringpool-alloc-bytes=9216
D [14/May/2009:19:05:17 +0200] Report: stringpool-total-bytes=14464
D [14/May/2009:19:06:05 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:06:05 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:06:05 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:06:05 +0200] Get-Notifications /
D [14/May/2009:19:06:05 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:06:05 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:06:05 +0200] cupsdCloseClient: 9
D [14/May/2009:19:06:17 +0200] Report: clients=0
D [14/May/2009:19:06:17 +0200] Report: jobs=10
D [14/May/2009:19:06:17 +0200] Report: jobs-active=1
D [14/May/2009:19:06:17 +0200] Report: printers=3
D [14/May/2009:19:06:17 +0200] Report: printers-implicit=0
D [14/May/2009:19:06:17 +0200] Report: stringpool-string-count=699
D [14/May/2009:19:06:17 +0200] Report: stringpool-alloc-bytes=9216
D [14/May/2009:19:06:17 +0200] Report: stringpool-total-bytes=14464
D [14/May/2009:19:06:58 +0200] [Job 44] Found: %%PageTrailer
D [14/May/2009:19:06:58 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:06:58 +0200] [Job 44] 
D [14/May/2009:19:06:58 +0200] [Job 44] Found: %%Trailer
D [14/May/2009:19:06:58 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:06:58 +0200] [Job 44] 
D [14/May/2009:19:06:58 +0200] [Job 44] Found: %%Pages: 1
D [14/May/2009:19:06:58 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:06:58 +0200] [Job 44] 
D [14/May/2009:19:06:58 +0200] [Job 44] Found: %%BoundingBox: 18 86 578 778
D [14/May/2009:19:06:58 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:06:58 +0200] [Job 44] 
D [14/May/2009:19:06:58 +0200] [Job 44] Found: %%HiResBoundingBox: 18.000000 86.600000 577.300000 777.800000
D [14/May/2009:19:06:58 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:06:58 +0200] [Job 44] 
D [14/May/2009:19:06:58 +0200] [Job 44] Found: %%EOF
D [14/May/2009:19:06:58 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:06:58 +0200] [Job 44] 
D [14/May/2009:19:06:58 +0200] [Job 44] 
D [14/May/2009:19:06:58 +0200] [Job 44] Closing renderer
D [14/May/2009:19:07:05 +0200] cupsdAcceptClient: 9 from localhost (Domain)
D [14/May/2009:19:07:05 +0200] cupsdReadClient: 9 POST / HTTP/1.1
D [14/May/2009:19:07:05 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:07:05 +0200] Get-Notifications /
D [14/May/2009:19:07:05 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:07:05 +0200] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
D [14/May/2009:19:07:05 +0200] cupsdCloseClient: 9
D [14/May/2009:19:07:07 +0200] Discarding unused job-progress event...
D [14/May/2009:19:07:07 +0200] [Job 44] Read 8192 bytes of print data...
I [14/May/2009:19:07:07 +0200] Saving subscriptions.conf...
I [14/May/2009:19:07:07 +0200] Saving subscriptions.conf...
I [14/May/2009:19:07:07 +0200] Saving subscriptions.conf...
D [14/May/2009:19:07:07 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:07:07 +0200] [Job 44] Read 8192 bytes of print data...
E [14/May/2009:19:07:07 +0200] [Job 44] Unable to write print data: Broken pipe
I [14/May/2009:19:07:07 +0200] Saving subscriptions.conf...
E [14/May/2009:19:07:07 +0200] PID 4578 (/usr/lib/cups/backend/socket) stopped with status 1!
D [14/May/2009:19:07:07 +0200] [Job 44] renderer exited with status 0
D [14/May/2009:19:07:07 +0200] [Job 44] kid4 exited with status 0
D [14/May/2009:19:07:07 +0200] [Job 44] kid3 finished
D [14/May/2009:19:07:07 +0200] [Job 44] kid3 exited with status 0
D [14/May/2009:19:07:07 +0200] [Job 44] pdf-to-ps exited with status 0
D [14/May/2009:19:07:07 +0200] [Job 44] 
D [14/May/2009:19:07:07 +0200] [Job 44] Closing foomatic-rip.
D [14/May/2009:19:07:07 +0200] PID 4577 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [14/May/2009:19:07:07 +0200] [Job 44] File 0 is complete.
I [14/May/2009:19:07:07 +0200] [Job 44] Backend returned status 1 (failed)
I [14/May/2009:19:07:07 +0200] Saving subscriptions.conf...
D [14/May/2009:19:07:07 +0200] set_hold_until: hold_until = 1242321127
I [14/May/2009:19:07:07 +0200] Saving subscriptions.conf...
D [14/May/2009:19:07:07 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:07:07 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:07:07 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:07:07 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:07:07 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:07:07 +0200] cupsdCloseClient: 11
D [14/May/2009:19:07:07 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:07:07 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:07:07 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:07:07 +0200] Get-Notifications /
D [14/May/2009:19:07:07 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:07:07 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:07:07 +0200] cupsdAcceptClient: 12 from localhost (Domain)
D [14/May/2009:19:07:07 +0200] cupsdReadClient: 12 POST / HTTP/1.1
D [14/May/2009:19:07:07 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:07:07 +0200] Get-Printer-Attributes ipp://boromir:631/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:07:07 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [14/May/2009:19:07:07 +0200] cupsdReadClient: 12 POST / HTTP/1.1
D [14/May/2009:19:07:07 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:07:07 +0200] Get-Job-Attributes ipp://localhost/jobs/44
D [14/May/2009:19:07:07 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [14/May/2009:19:07:07 +0200] cupsdCloseClient: 11
D [14/May/2009:19:07:19 +0200] Report: clients=1
D [14/May/2009:19:07:19 +0200] Report: jobs=10
D [14/May/2009:19:07:19 +0200] Report: jobs-active=1
D [14/May/2009:19:07:19 +0200] Report: printers=3
D [14/May/2009:19:07:19 +0200] Report: printers-implicit=0
D [14/May/2009:19:07:19 +0200] Report: stringpool-string-count=839
D [14/May/2009:19:07:19 +0200] Report: stringpool-alloc-bytes=9840
D [14/May/2009:19:07:19 +0200] Report: stringpool-total-bytes=17928
D [14/May/2009:19:08:25 +0200] Report: clients=1
D [14/May/2009:19:08:25 +0200] Report: jobs=10
D [14/May/2009:19:08:25 +0200] Report: jobs-active=1
D [14/May/2009:19:08:25 +0200] Report: printers=3
D [14/May/2009:19:08:25 +0200] Report: printers-implicit=0
D [14/May/2009:19:08:25 +0200] Report: stringpool-string-count=839
D [14/May/2009:19:08:25 +0200] Report: stringpool-alloc-bytes=9840
D [14/May/2009:19:08:25 +0200] Report: stringpool-total-bytes=17928
D [14/May/2009:19:09:31 +0200] Report: clients=1
D [14/May/2009:19:09:31 +0200] Report: jobs=10
D [14/May/2009:19:09:31 +0200] Report: jobs-active=1
D [14/May/2009:19:09:31 +0200] Report: printers=3
D [14/May/2009:19:09:31 +0200] Report: printers-implicit=0
D [14/May/2009:19:09:31 +0200] Report: stringpool-string-count=839
D [14/May/2009:19:09:31 +0200] Report: stringpool-alloc-bytes=9840
D [14/May/2009:19:09:31 +0200] Report: stringpool-total-bytes=17928
D [14/May/2009:19:10:37 +0200] Report: clients=1
D [14/May/2009:19:10:37 +0200] Report: jobs=10
D [14/May/2009:19:10:37 +0200] Report: jobs-active=1
D [14/May/2009:19:10:37 +0200] Report: printers=3
D [14/May/2009:19:10:37 +0200] Report: printers-implicit=0
D [14/May/2009:19:10:37 +0200] Report: stringpool-string-count=839
D [14/May/2009:19:10:37 +0200] Report: stringpool-alloc-bytes=9840
D [14/May/2009:19:10:37 +0200] Report: stringpool-total-bytes=17928
D [14/May/2009:19:11:43 +0200] Report: clients=1
D [14/May/2009:19:11:43 +0200] Report: jobs=10
D [14/May/2009:19:11:43 +0200] Report: jobs-active=1
D [14/May/2009:19:11:43 +0200] Report: printers=3
D [14/May/2009:19:11:43 +0200] Report: printers-implicit=0
D [14/May/2009:19:11:43 +0200] Report: stringpool-string-count=839
D [14/May/2009:19:11:43 +0200] Report: stringpool-alloc-bytes=9840
D [14/May/2009:19:11:43 +0200] Report: stringpool-total-bytes=17928
D [14/May/2009:19:12:08 +0200] Closing client 12 after 300 seconds of inactivity...
D [14/May/2009:19:12:08 +0200] cupsdCloseClient: 12
I [14/May/2009:19:12:19 +0200] Saving subscriptions.conf...
D [14/May/2009:19:12:19 +0200] [Job 44] job-sheets=none,none
D [14/May/2009:19:12:19 +0200] [Job 44] banner_page = 0
D [14/May/2009:19:12:19 +0200] [Job 44] argv[0]="magicolor-2530-DL-do-not-use"
D [14/May/2009:19:12:19 +0200] [Job 44] argv[1]="44"
D [14/May/2009:19:12:19 +0200] [Job 44] argv[2]="laurent"
D [14/May/2009:19:12:19 +0200] [Job 44] argv[3]="out.pnm"
D [14/May/2009:19:12:19 +0200] [Job 44] argv[4]="1"
D [14/May/2009:19:12:19 +0200] [Job 44] argv[5]="Resolution=600x600dpi Quality=normal MediaType=plain NupOrient=port ColorMode=ICM PageSize=A4 Nup=1up number-up=1 ICM=km2530-jc Duplex=None InputSlot=Auto job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d"
D [14/May/2009:19:12:19 +0200] [Job 44] argv[6]="/var/spool/cups/d00044-001"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[9]="SERVER_ADMIN=root@boromir"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[10]="SOFTWARE=CUPS/1.3.9"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[12]="TZ=Europe/Paris"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[13]="USER=root"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[16]="IPP_PORT=631"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[17]="CHARSET=utf-8"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[18]="LANG=fr_FR.UTF8"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[19]="PPD=/etc/cups/ppd/magicolor-2530-DL-do-not-use.ppd"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[20]="RIP_MAX_CACHE=8m"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[21]="CONTENT_TYPE=application/pdf"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[22]="DEVICE_URI=socket://192.168.1.117:9100"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[23]="PRINTER=magicolor-2530-DL-do-not-use"
D [14/May/2009:19:12:19 +0200] [Job 44] envp[24]="FINAL_CONTENT_TYPE=printer/magicolor-2530-DL-do-not-use"
I [14/May/2009:19:12:19 +0200] [Job 44] Started filter /usr/lib/cups/filter/pdftopdf (PID 4850)
I [14/May/2009:19:12:19 +0200] [Job 44] Started filter /usr/lib/cups/filter/foomatic-rip (PID 4851)
I [14/May/2009:19:12:20 +0200] [Job 44] Started backend /usr/lib/cups/backend/socket (PID 4852)
I [14/May/2009:19:12:20 +0200] Saving subscriptions.conf...
D [14/May/2009:19:12:20 +0200] [Job 44] Connected to 192.168.1.117:9100 (IPv4)...
D [14/May/2009:19:12:20 +0200] [Job 44] backendRunLoop(print_fd=0, device_fd=5, use_bc=1, side_cb=0xb7fa1fc0)
D [14/May/2009:19:12:20 +0200] [Job 44] Getting input from file 
D [14/May/2009:19:12:20 +0200] [Job 44] foomatic-rip version 4.0.0.195 running...
D [14/May/2009:19:12:20 +0200] [Job 44] Parsing PPD file ...
D [14/May/2009:19:12:20 +0200] [Job 44] Added option PageSize
D [14/May/2009:19:12:20 +0200] [Job 44] Added option Quality
D [14/May/2009:19:12:20 +0200] [Job 44] Added option PrinterType
D [14/May/2009:19:12:20 +0200] [Job 44] Added option ColorMode
D [14/May/2009:19:12:20 +0200] [Job 44] Added option Resolution
D [14/May/2009:19:12:20 +0200] [Job 44] Added option ImageableArea
D [14/May/2009:19:12:20 +0200] [Job 44] Added option PaperDimension
D [14/May/2009:19:12:20 +0200] [Job 44] Added option InputSlot
D [14/May/2009:19:12:20 +0200] [Job 44] Added option MediaType
D [14/May/2009:19:12:20 +0200] [Job 44] Added option Duplex
D [14/May/2009:19:12:20 +0200] [Job 44] Added option Copies
D [14/May/2009:19:12:20 +0200] [Job 44] Added option ICM
D [14/May/2009:19:12:20 +0200] [Job 44] Added option Nup
D [14/May/2009:19:12:20 +0200] [Job 44] Added option NupOrient
D [14/May/2009:19:12:20 +0200] [Job 44] Added option Font
D [14/May/2009:19:12:20 +0200] [Job 44] 
D [14/May/2009:19:12:20 +0200] [Job 44] Parameter Summary
D [14/May/2009:19:12:20 +0200] [Job 44] -----------------
D [14/May/2009:19:12:20 +0200] [Job 44] 
D [14/May/2009:19:12:20 +0200] [Job 44] Spooler: cups
D [14/May/2009:19:12:20 +0200] [Job 44] Printer: magicolor-2530-DL-do-not-use
D [14/May/2009:19:12:20 +0200] [Job 44] Shell: /bin/bash
D [14/May/2009:19:12:20 +0200] [Job 44] PPD file: /etc/cups/ppd/magicolor-2530-DL-do-not-use.ppd
D [14/May/2009:19:12:20 +0200] [Job 44] ATTR file: 
D [14/May/2009:19:12:20 +0200] [Job 44] Printer model: KONICA MINOLTA magicolor 2530 DL Foomatic/foo2lava (recommended)
D [14/May/2009:19:12:20 +0200] [Job 44] Job title: out.pnm
D [14/May/2009:19:12:20 +0200] [Job 44] File(s) to be printed:
D [14/May/2009:19:12:20 +0200] [Job 44] <STDIN>
D [14/May/2009:19:12:20 +0200] [Job 44] 
I [14/May/2009:19:12:20 +0200] Saving subscriptions.conf...
D [14/May/2009:19:12:20 +0200] [Job 44] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [14/May/2009:19:12:20 +0200] [Job 44] Printing system options:
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'number-up=1'
D [14/May/2009:19:12:20 +0200] [Job 44] Unknown option number-up=1.
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d'
D [14/May/2009:19:12:20 +0200] [Job 44] Unknown option job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d.
D [14/May/2009:19:12:20 +0200] [Job 44] Options from the PPD file:
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'Resolution=600x600dpi'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'Quality=normal'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'MediaType=plain'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'NupOrient=port'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'ColorMode=ICM'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'PageSize=A4'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'Nup=1up'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'ICM=km2530-jc'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'Duplex=None'
D [14/May/2009:19:12:20 +0200] [Job 44] Pondering option 'InputSlot=Auto'
D [14/May/2009:19:12:20 +0200] [Job 44] 
D [14/May/2009:19:12:20 +0200] [Job 44] ================================================
D [14/May/2009:19:12:20 +0200] [Job 44] 
D [14/May/2009:19:12:20 +0200] [Job 44] File: <STDIN>
D [14/May/2009:19:12:20 +0200] [Job 44] 
D [14/May/2009:19:12:20 +0200] [Job 44] ================================================
D [14/May/2009:19:12:20 +0200] [Job 44] 
D [14/May/2009:19:12:20 +0200] [Job 44] Filetype: PDF
D [14/May/2009:19:12:20 +0200] [Job 44] Driver does not understand PDF input, converting to PostScript
D [14/May/2009:19:12:20 +0200] [Job 44] Starting process "pdf-to-ps" (generation 1)
D [14/May/2009:19:12:20 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:12:20 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:12:20 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:12:20 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:12:20 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:12:20 +0200] cupsdCloseClient: 11
D [14/May/2009:19:12:20 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:12:20 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:12:20 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:12:20 +0200] Get-Notifications /
D [14/May/2009:19:12:20 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:12:20 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:12:20 +0200] cupsdCloseClient: 11
D [14/May/2009:19:12:31 +0200] PID 4850 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [14/May/2009:19:12:32 +0200] [Job 44] Filetype: PostScript
D [14/May/2009:19:12:32 +0200] [Job 44] Reading PostScript input ...
D [14/May/2009:19:12:32 +0200] [Job 44] --> This document is DSC-conforming!
D [14/May/2009:19:12:32 +0200] [Job 44] 
D [14/May/2009:19:12:32 +0200] [Job 44] -----------
D [14/May/2009:19:12:32 +0200] [Job 44] Found: %%BeginProlog
D [14/May/2009:19:12:32 +0200] [Job 44] Inserting option code into "Prolog" section.
D [14/May/2009:19:12:32 +0200] [Job 44] Found: %%EndProlog
D [14/May/2009:19:12:32 +0200] [Job 44] 
D [14/May/2009:19:12:32 +0200] [Job 44] -----------
D [14/May/2009:19:12:32 +0200] [Job 44] New page: %%Page: 1 1
D [14/May/2009:19:12:32 +0200] [Job 44] "Setup" section is missing, inserting it.
D [14/May/2009:19:12:32 +0200] [Job 44] Inserting PostScript code for CUPS' page accounting
D [14/May/2009:19:12:32 +0200] [Job 44] Inserting option code into "Setup" section.
D [14/May/2009:19:12:32 +0200] [Job 44] No page header or page header not DSC-conforming
D [14/May/2009:19:12:32 +0200] [Job 44] "PageSetup" section is missing, inserting it.
D [14/May/2009:19:12:32 +0200] [Job 44] Inserting option code into "PageSetup" section.
D [14/May/2009:19:12:32 +0200] [Job 44] Stopping search for page header options
D [14/May/2009:19:12:32 +0200] [Job 44] Found: 451 7775 5 3 rf
D [14/May/2009:19:12:32 +0200] [Job 44] --> Output goes directly to the renderer now.
D [14/May/2009:19:12:32 +0200] [Job 44] 
D [14/May/2009:19:12:32 +0200] [Job 44] 
D [14/May/2009:19:12:32 +0200] [Job 44] Starting renderer with command: "foo2lava-wrapper -z0   -c -C10 -r600x600 -p26 -m0 -s255   -d1 -Gkm2530-jconner-d50.icm "
D [14/May/2009:19:12:32 +0200] [Job 44] Starting process "kid3" (generation 1)
D [14/May/2009:19:12:32 +0200] [Job 44] Starting process "kid4" (generation 2)
D [14/May/2009:19:12:32 +0200] [Job 44] JCL: %-12345X@PJL
D [14/May/2009:19:12:32 +0200] [Job 44] <job data> 
D [14/May/2009:19:12:32 +0200] [Job 44] 
D [14/May/2009:19:12:32 +0200] [Job 44] Starting process "renderer" (generation 2)
D [14/May/2009:19:12:33 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:12:33 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:12:33 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:12:34 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:12:46 +0200] Report: clients=0
D [14/May/2009:19:12:46 +0200] Report: jobs=10
D [14/May/2009:19:12:46 +0200] Report: jobs-active=1
D [14/May/2009:19:12:46 +0200] Report: printers=3
D [14/May/2009:19:12:46 +0200] Report: printers-implicit=0
D [14/May/2009:19:12:46 +0200] Report: stringpool-string-count=903
D [14/May/2009:19:12:46 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:12:46 +0200] Report: stringpool-total-bytes=19360
D [14/May/2009:19:13:52 +0200] Report: clients=0
D [14/May/2009:19:13:52 +0200] Report: jobs=10
D [14/May/2009:19:13:52 +0200] Report: jobs-active=1
D [14/May/2009:19:13:52 +0200] Report: printers=3
D [14/May/2009:19:13:52 +0200] Report: printers-implicit=0
D [14/May/2009:19:13:52 +0200] Report: stringpool-string-count=903
D [14/May/2009:19:13:52 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:13:52 +0200] Report: stringpool-total-bytes=19360
D [14/May/2009:19:14:58 +0200] Report: clients=0
D [14/May/2009:19:14:58 +0200] Report: jobs=10
D [14/May/2009:19:14:58 +0200] Report: jobs-active=1
D [14/May/2009:19:14:58 +0200] Report: printers=3
D [14/May/2009:19:14:58 +0200] Report: printers-implicit=0
D [14/May/2009:19:14:58 +0200] Report: stringpool-string-count=903
D [14/May/2009:19:14:58 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:14:58 +0200] Report: stringpool-total-bytes=19360
D [14/May/2009:19:16:04 +0200] Report: clients=0
D [14/May/2009:19:16:04 +0200] Report: jobs=10
D [14/May/2009:19:16:04 +0200] Report: jobs-active=1
D [14/May/2009:19:16:04 +0200] Report: printers=3
D [14/May/2009:19:16:04 +0200] Report: printers-implicit=0
D [14/May/2009:19:16:04 +0200] Report: stringpool-string-count=903
D [14/May/2009:19:16:04 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:16:04 +0200] Report: stringpool-total-bytes=19360
D [14/May/2009:19:17:10 +0200] Report: clients=0
D [14/May/2009:19:17:10 +0200] Report: jobs=10
D [14/May/2009:19:17:10 +0200] Report: jobs-active=1
D [14/May/2009:19:17:10 +0200] Report: printers=3
D [14/May/2009:19:17:10 +0200] Report: printers-implicit=0
D [14/May/2009:19:17:10 +0200] Report: stringpool-string-count=903
D [14/May/2009:19:17:10 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:17:10 +0200] Report: stringpool-total-bytes=19360
D [14/May/2009:19:17:40 +0200] [Job 44] Found: %%PageTrailer
D [14/May/2009:19:17:40 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:17:40 +0200] [Job 44] 
D [14/May/2009:19:17:40 +0200] [Job 44] Found: %%Trailer
D [14/May/2009:19:17:40 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:17:40 +0200] [Job 44] 
D [14/May/2009:19:17:40 +0200] [Job 44] Found: %%Pages: 1
D [14/May/2009:19:17:40 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:17:40 +0200] [Job 44] 
D [14/May/2009:19:17:40 +0200] [Job 44] Found: %%BoundingBox: 18 86 578 778
D [14/May/2009:19:17:40 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:17:40 +0200] [Job 44] 
D [14/May/2009:19:17:40 +0200] [Job 44] Found: %%HiResBoundingBox: 18.000000 86.600000 577.300000 777.800000
D [14/May/2009:19:17:40 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:17:40 +0200] [Job 44] 
D [14/May/2009:19:17:40 +0200] [Job 44] Found: %%EOF
D [14/May/2009:19:17:40 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:17:40 +0200] [Job 44] 
D [14/May/2009:19:17:40 +0200] [Job 44] 
D [14/May/2009:19:17:40 +0200] [Job 44] Closing renderer
D [14/May/2009:19:17:48 +0200] Discarding unused job-progress event...
D [14/May/2009:19:17:48 +0200] [Job 44] Read 8192 bytes of print data...
I [14/May/2009:19:17:48 +0200] Saving subscriptions.conf...
I [14/May/2009:19:17:48 +0200] Saving subscriptions.conf...
I [14/May/2009:19:17:48 +0200] Saving subscriptions.conf...
D [14/May/2009:19:17:48 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:17:48 +0200] [Job 44] Read 8192 bytes of print data...
E [14/May/2009:19:17:48 +0200] [Job 44] Unable to write print data: Broken pipe
I [14/May/2009:19:17:48 +0200] Saving subscriptions.conf...
E [14/May/2009:19:17:48 +0200] PID 4852 (/usr/lib/cups/backend/socket) stopped with status 1!
D [14/May/2009:19:17:48 +0200] [Job 44] renderer exited with status 0
D [14/May/2009:19:17:48 +0200] [Job 44] kid4 exited with status 0
D [14/May/2009:19:17:48 +0200] [Job 44] kid3 finished
D [14/May/2009:19:17:48 +0200] [Job 44] kid3 exited with status 0
D [14/May/2009:19:17:48 +0200] [Job 44] pdf-to-ps exited with status 0
D [14/May/2009:19:17:48 +0200] [Job 44] 
D [14/May/2009:19:17:48 +0200] [Job 44] Closing foomatic-rip.
D [14/May/2009:19:17:48 +0200] PID 4851 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [14/May/2009:19:17:48 +0200] [Job 44] File 0 is complete.
I [14/May/2009:19:17:48 +0200] [Job 44] Backend returned status 1 (failed)
I [14/May/2009:19:17:48 +0200] Saving subscriptions.conf...
D [14/May/2009:19:17:48 +0200] set_hold_until: hold_until = 1242321768
I [14/May/2009:19:17:48 +0200] Saving subscriptions.conf...
D [14/May/2009:19:17:49 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:17:49 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:17:49 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:17:49 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:17:49 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:17:49 +0200] cupsdCloseClient: 11
D [14/May/2009:19:17:49 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:17:49 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:17:49 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:17:49 +0200] Get-Notifications /
D [14/May/2009:19:17:49 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:17:49 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:17:49 +0200] cupsdAcceptClient: 12 from localhost (Domain)
D [14/May/2009:19:17:49 +0200] cupsdReadClient: 12 POST / HTTP/1.1
D [14/May/2009:19:17:49 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:17:49 +0200] Get-Printer-Attributes ipp://boromir:631/printers/magicolor-2530-DL-do-not-use
D [14/May/2009:19:17:49 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [14/May/2009:19:17:49 +0200] cupsdReadClient: 12 POST / HTTP/1.1
D [14/May/2009:19:17:49 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:17:49 +0200] Get-Job-Attributes ipp://localhost/jobs/44
D [14/May/2009:19:17:49 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [14/May/2009:19:17:49 +0200] cupsdCloseClient: 11
D [14/May/2009:19:18:12 +0200] Report: clients=1
D [14/May/2009:19:18:12 +0200] Report: jobs=10
D [14/May/2009:19:18:12 +0200] Report: jobs-active=1
D [14/May/2009:19:18:12 +0200] Report: printers=3
D [14/May/2009:19:18:12 +0200] Report: printers-implicit=0
D [14/May/2009:19:18:12 +0200] Report: stringpool-string-count=1016
D [14/May/2009:19:18:12 +0200] Report: stringpool-alloc-bytes=9904
D [14/May/2009:19:18:12 +0200] Report: stringpool-total-bytes=22096
D [14/May/2009:19:19:18 +0200] Report: clients=1
D [14/May/2009:19:19:18 +0200] Report: jobs=10
D [14/May/2009:19:19:18 +0200] Report: jobs-active=1
D [14/May/2009:19:19:18 +0200] Report: printers=3
D [14/May/2009:19:19:18 +0200] Report: printers-implicit=0
D [14/May/2009:19:19:18 +0200] Report: stringpool-string-count=1016
D [14/May/2009:19:19:18 +0200] Report: stringpool-alloc-bytes=9904
D [14/May/2009:19:19:18 +0200] Report: stringpool-total-bytes=22096
D [14/May/2009:19:20:24 +0200] Report: clients=1
D [14/May/2009:19:20:24 +0200] Report: jobs=10
D [14/May/2009:19:20:24 +0200] Report: jobs-active=1
D [14/May/2009:19:20:24 +0200] Report: printers=3
D [14/May/2009:19:20:24 +0200] Report: printers-implicit=0
D [14/May/2009:19:20:24 +0200] Report: stringpool-string-count=1016
D [14/May/2009:19:20:24 +0200] Report: stringpool-alloc-bytes=9904
D [14/May/2009:19:20:24 +0200] Report: stringpool-total-bytes=22096
D [14/May/2009:19:21:30 +0200] Report: clients=1
D [14/May/2009:19:21:30 +0200] Report: jobs=10
D [14/May/2009:19:21:30 +0200] Report: jobs-active=1
D [14/May/2009:19:21:30 +0200] Report: printers=3
D [14/May/2009:19:21:30 +0200] Report: printers-implicit=0
D [14/May/2009:19:21:30 +0200] Report: stringpool-string-count=1016
D [14/May/2009:19:21:30 +0200] Report: stringpool-alloc-bytes=9904
D [14/May/2009:19:21:30 +0200] Report: stringpool-total-bytes=22096
D [14/May/2009:19:22:36 +0200] Report: clients=1
D [14/May/2009:19:22:36 +0200] Report: jobs=10
D [14/May/2009:19:22:36 +0200] Report: jobs-active=1
D [14/May/2009:19:22:36 +0200] Report: printers=3
D [14/May/2009:19:22:36 +0200] Report: printers-implicit=0
D [14/May/2009:19:22:36 +0200] Report: stringpool-string-count=1016
D [14/May/2009:19:22:36 +0200] Report: stringpool-alloc-bytes=9904
D [14/May/2009:19:22:36 +0200] Report: stringpool-total-bytes=22096
D [14/May/2009:19:22:50 +0200] Closing client 12 after 300 seconds of inactivity...
D [14/May/2009:19:22:50 +0200] cupsdCloseClient: 12
I [14/May/2009:19:23:01 +0200] Saving subscriptions.conf...
D [14/May/2009:19:23:01 +0200] [Job 44] job-sheets=none,none
D [14/May/2009:19:23:01 +0200] [Job 44] banner_page = 0
D [14/May/2009:19:23:01 +0200] [Job 44] argv[0]="magicolor-2530-DL-do-not-use"
D [14/May/2009:19:23:01 +0200] [Job 44] argv[1]="44"
D [14/May/2009:19:23:01 +0200] [Job 44] argv[2]="laurent"
D [14/May/2009:19:23:01 +0200] [Job 44] argv[3]="out.pnm"
D [14/May/2009:19:23:01 +0200] [Job 44] argv[4]="1"
D [14/May/2009:19:23:01 +0200] [Job 44] argv[5]="Resolution=600x600dpi Quality=normal MediaType=plain NupOrient=port ColorMode=ICM PageSize=A4 Nup=1up number-up=1 ICM=km2530-jc Duplex=None InputSlot=Auto job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d"
D [14/May/2009:19:23:01 +0200] [Job 44] argv[6]="/var/spool/cups/d00044-001"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[9]="SERVER_ADMIN=root@boromir"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[10]="SOFTWARE=CUPS/1.3.9"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[12]="TZ=Europe/Paris"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[13]="USER=root"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[16]="IPP_PORT=631"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[17]="CHARSET=utf-8"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[18]="LANG=fr_FR.UTF8"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[19]="PPD=/etc/cups/ppd/magicolor-2530-DL-do-not-use.ppd"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[20]="RIP_MAX_CACHE=8m"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[21]="CONTENT_TYPE=application/pdf"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[22]="DEVICE_URI=socket://192.168.1.117:9100"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[23]="PRINTER=magicolor-2530-DL-do-not-use"
D [14/May/2009:19:23:01 +0200] [Job 44] envp[24]="FINAL_CONTENT_TYPE=printer/magicolor-2530-DL-do-not-use"
I [14/May/2009:19:23:01 +0200] [Job 44] Started filter /usr/lib/cups/filter/pdftopdf (PID 5116)
I [14/May/2009:19:23:01 +0200] [Job 44] Started filter /usr/lib/cups/filter/foomatic-rip (PID 5117)
I [14/May/2009:19:23:01 +0200] [Job 44] Started backend /usr/lib/cups/backend/socket (PID 5118)
I [14/May/2009:19:23:01 +0200] Saving subscriptions.conf...
D [14/May/2009:19:23:01 +0200] [Job 44] Getting input from file 
D [14/May/2009:19:23:01 +0200] [Job 44] foomatic-rip version 4.0.0.195 running...
D [14/May/2009:19:23:01 +0200] [Job 44] Parsing PPD file ...
D [14/May/2009:19:23:01 +0200] [Job 44] Added option PageSize
D [14/May/2009:19:23:01 +0200] [Job 44] Added option Quality
D [14/May/2009:19:23:01 +0200] [Job 44] Added option PrinterType
D [14/May/2009:19:23:01 +0200] [Job 44] Added option ColorMode
D [14/May/2009:19:23:01 +0200] [Job 44] Added option Resolution
D [14/May/2009:19:23:01 +0200] [Job 44] Added option ImageableArea
D [14/May/2009:19:23:01 +0200] [Job 44] Added option PaperDimension
D [14/May/2009:19:23:01 +0200] [Job 44] Added option InputSlot
D [14/May/2009:19:23:01 +0200] [Job 44] Added option MediaType
D [14/May/2009:19:23:01 +0200] [Job 44] Added option Duplex
D [14/May/2009:19:23:01 +0200] [Job 44] Added option Copies
D [14/May/2009:19:23:01 +0200] [Job 44] Added option ICM
D [14/May/2009:19:23:01 +0200] [Job 44] Added option Nup
D [14/May/2009:19:23:01 +0200] [Job 44] Added option NupOrient
D [14/May/2009:19:23:01 +0200] [Job 44] Added option Font
D [14/May/2009:19:23:01 +0200] [Job 44] 
D [14/May/2009:19:23:01 +0200] [Job 44] Parameter Summary
D [14/May/2009:19:23:01 +0200] [Job 44] -----------------
D [14/May/2009:19:23:01 +0200] [Job 44] 
D [14/May/2009:19:23:01 +0200] [Job 44] Spooler: cups
D [14/May/2009:19:23:01 +0200] [Job 44] Printer: magicolor-2530-DL-do-not-use
D [14/May/2009:19:23:01 +0200] [Job 44] Shell: /bin/bash
D [14/May/2009:19:23:01 +0200] [Job 44] PPD file: /etc/cups/ppd/magicolor-2530-DL-do-not-use.ppd
D [14/May/2009:19:23:01 +0200] [Job 44] ATTR file: 
D [14/May/2009:19:23:01 +0200] [Job 44] Printer model: KONICA MINOLTA magicolor 2530 DL Foomatic/foo2lava (recommended)
D [14/May/2009:19:23:01 +0200] [Job 44] Job title: out.pnm
D [14/May/2009:19:23:01 +0200] [Job 44] File(s) to be printed:
D [14/May/2009:19:23:01 +0200] [Job 44] <STDIN>
D [14/May/2009:19:23:01 +0200] [Job 44] 
D [14/May/2009:19:23:01 +0200] [Job 44] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [14/May/2009:19:23:01 +0200] [Job 44] Printing system options:
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'number-up=1'
D [14/May/2009:19:23:01 +0200] [Job 44] Unknown option number-up=1.
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d'
D [14/May/2009:19:23:01 +0200] [Job 44] Unknown option job-uuid=urn:uuid:f2750e1b-c9f0-3105-5653-d5db7ad83b3d.
D [14/May/2009:19:23:01 +0200] [Job 44] Options from the PPD file:
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'Resolution=600x600dpi'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'Quality=normal'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'MediaType=plain'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'NupOrient=port'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'ColorMode=ICM'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'PageSize=A4'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'Nup=1up'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'ICM=km2530-jc'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'Duplex=None'
D [14/May/2009:19:23:01 +0200] [Job 44] Pondering option 'InputSlot=Auto'
D [14/May/2009:19:23:01 +0200] [Job 44] 
D [14/May/2009:19:23:01 +0200] [Job 44] ================================================
D [14/May/2009:19:23:01 +0200] [Job 44] 
D [14/May/2009:19:23:01 +0200] [Job 44] File: <STDIN>
D [14/May/2009:19:23:01 +0200] [Job 44] 
D [14/May/2009:19:23:01 +0200] [Job 44] ================================================
D [14/May/2009:19:23:01 +0200] [Job 44] 
D [14/May/2009:19:23:01 +0200] [Job 44] Connected to 192.168.1.117:9100 (IPv4)...
D [14/May/2009:19:23:01 +0200] [Job 44] backendRunLoop(print_fd=0, device_fd=5, use_bc=1, side_cb=0xb7fcdfc0)
D [14/May/2009:19:23:01 +0200] [Job 44] Filetype: PDF
D [14/May/2009:19:23:01 +0200] [Job 44] Driver does not understand PDF input, converting to PostScript
D [14/May/2009:19:23:01 +0200] [Job 44] Starting process "pdf-to-ps" (generation 1)
I [14/May/2009:19:23:01 +0200] Saving subscriptions.conf...
D [14/May/2009:19:23:01 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:23:01 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:23:01 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:23:01 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:23:01 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:23:01 +0200] cupsdCloseClient: 11
D [14/May/2009:19:23:01 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:23:01 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:23:01 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:23:01 +0200] Get-Notifications /
D [14/May/2009:19:23:01 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:23:01 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:23:01 +0200] cupsdCloseClient: 11
D [14/May/2009:19:23:10 +0200] PID 5116 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [14/May/2009:19:23:10 +0200] [Job 44] Filetype: PostScript
D [14/May/2009:19:23:10 +0200] [Job 44] Reading PostScript input ...
D [14/May/2009:19:23:10 +0200] [Job 44] --> This document is DSC-conforming!
D [14/May/2009:19:23:10 +0200] [Job 44] 
D [14/May/2009:19:23:10 +0200] [Job 44] -----------
D [14/May/2009:19:23:10 +0200] [Job 44] Found: %%BeginProlog
D [14/May/2009:19:23:10 +0200] [Job 44] Inserting option code into "Prolog" section.
D [14/May/2009:19:23:10 +0200] [Job 44] Found: %%EndProlog
D [14/May/2009:19:23:10 +0200] [Job 44] 
D [14/May/2009:19:23:10 +0200] [Job 44] -----------
D [14/May/2009:19:23:10 +0200] [Job 44] New page: %%Page: 1 1
D [14/May/2009:19:23:10 +0200] [Job 44] "Setup" section is missing, inserting it.
D [14/May/2009:19:23:10 +0200] [Job 44] Inserting PostScript code for CUPS' page accounting
D [14/May/2009:19:23:10 +0200] [Job 44] Inserting option code into "Setup" section.
D [14/May/2009:19:23:10 +0200] [Job 44] No page header or page header not DSC-conforming
D [14/May/2009:19:23:10 +0200] [Job 44] "PageSetup" section is missing, inserting it.
D [14/May/2009:19:23:10 +0200] [Job 44] Inserting option code into "PageSetup" section.
D [14/May/2009:19:23:10 +0200] [Job 44] Stopping search for page header options
D [14/May/2009:19:23:10 +0200] [Job 44] Found: 451 7775 5 3 rf
D [14/May/2009:19:23:10 +0200] [Job 44] --> Output goes directly to the renderer now.
D [14/May/2009:19:23:10 +0200] [Job 44] 
D [14/May/2009:19:23:10 +0200] [Job 44] 
D [14/May/2009:19:23:10 +0200] [Job 44] Starting renderer with command: "foo2lava-wrapper -z0   -c -C10 -r600x600 -p26 -m0 -s255   -d1 -Gkm2530-jconner-d50.icm "
D [14/May/2009:19:23:10 +0200] [Job 44] Starting process "kid3" (generation 1)
D [14/May/2009:19:23:10 +0200] [Job 44] Starting process "kid4" (generation 2)
D [14/May/2009:19:23:10 +0200] [Job 44] JCL: %-12345X@PJL
D [14/May/2009:19:23:10 +0200] [Job 44] <job data> 
D [14/May/2009:19:23:10 +0200] [Job 44] 
D [14/May/2009:19:23:10 +0200] [Job 44] Starting process "renderer" (generation 2)
D [14/May/2009:19:23:11 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:23:11 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:23:11 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:23:11 +0200] [Job 44] pcache: unable to open '~/.ghostscript/cache/gs_cache'
D [14/May/2009:19:23:45 +0200] Report: clients=0
D [14/May/2009:19:23:45 +0200] Report: jobs=10
D [14/May/2009:19:23:45 +0200] Report: jobs-active=1
D [14/May/2009:19:23:45 +0200] Report: printers=3
D [14/May/2009:19:23:45 +0200] Report: printers-implicit=0
D [14/May/2009:19:23:45 +0200] Report: stringpool-string-count=1080
D [14/May/2009:19:23:45 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:23:45 +0200] Report: stringpool-total-bytes=23520
D [14/May/2009:19:24:51 +0200] Report: clients=0
D [14/May/2009:19:24:51 +0200] Report: jobs=10
D [14/May/2009:19:24:51 +0200] Report: jobs-active=1
D [14/May/2009:19:24:51 +0200] Report: printers=3
D [14/May/2009:19:24:51 +0200] Report: printers-implicit=0
D [14/May/2009:19:24:51 +0200] Report: stringpool-string-count=1080
D [14/May/2009:19:24:51 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:24:51 +0200] Report: stringpool-total-bytes=23520
D [14/May/2009:19:25:57 +0200] Report: clients=0
D [14/May/2009:19:25:57 +0200] Report: jobs=10
D [14/May/2009:19:25:57 +0200] Report: jobs-active=1
D [14/May/2009:19:25:57 +0200] Report: printers=3
D [14/May/2009:19:25:57 +0200] Report: printers-implicit=0
D [14/May/2009:19:25:57 +0200] Report: stringpool-string-count=1080
D [14/May/2009:19:25:57 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:25:57 +0200] Report: stringpool-total-bytes=23520
D [14/May/2009:19:27:03 +0200] Report: clients=0
D [14/May/2009:19:27:03 +0200] Report: jobs=10
D [14/May/2009:19:27:03 +0200] Report: jobs-active=1
D [14/May/2009:19:27:03 +0200] Report: printers=3
D [14/May/2009:19:27:03 +0200] Report: printers-implicit=0
D [14/May/2009:19:27:03 +0200] Report: stringpool-string-count=1080
D [14/May/2009:19:27:03 +0200] Report: stringpool-alloc-bytes=9880
D [14/May/2009:19:27:03 +0200] Report: stringpool-total-bytes=23520
D [14/May/2009:19:27:50 +0200] [Job 44] Found: %%PageTrailer
D [14/May/2009:19:27:50 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:27:50 +0200] [Job 44] 
D [14/May/2009:19:27:50 +0200] [Job 44] Found: %%Trailer
D [14/May/2009:19:27:50 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:27:50 +0200] [Job 44] 
D [14/May/2009:19:27:50 +0200] [Job 44] Found: %%Pages: 1
D [14/May/2009:19:27:50 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:27:50 +0200] [Job 44] 
D [14/May/2009:19:27:50 +0200] [Job 44] Found: %%BoundingBox: 18 86 578 778
D [14/May/2009:19:27:50 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:27:50 +0200] [Job 44] 
D [14/May/2009:19:27:50 +0200] [Job 44] Found: %%HiResBoundingBox: 18.000000 86.600000 577.300000 777.800000
D [14/May/2009:19:27:50 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:27:50 +0200] [Job 44] 
D [14/May/2009:19:27:50 +0200] [Job 44] Found: %%EOF
D [14/May/2009:19:27:50 +0200] [Job 44] --> Continue DSC parsing now.
D [14/May/2009:19:27:50 +0200] [Job 44] 
D [14/May/2009:19:27:50 +0200] [Job 44] 
D [14/May/2009:19:27:50 +0200] [Job 44] Closing renderer
D [14/May/2009:19:27:55 +0200] Discarding unused job-progress event...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
I [14/May/2009:19:27:55 +0200] Saving subscriptions.conf...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:27:55 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:27:55 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:27:55 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:27:55 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:27:55 +0200] cupsdCloseClient: 11
D [14/May/2009:19:27:55 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:27:55 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:27:55 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:27:55 +0200] Get-Notifications /
D [14/May/2009:19:27:55 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:27:55 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:27:55 +0200] cupsdCloseClient: 11
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:55 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] renderer exited with status 0
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] kid4 exited with status 0
D [14/May/2009:19:27:56 +0200] [Job 44] kid3 finished
D [14/May/2009:19:27:56 +0200] [Job 44] kid3 exited with status 0
D [14/May/2009:19:27:56 +0200] [Job 44] pdf-to-ps exited with status 0
D [14/May/2009:19:27:56 +0200] [Job 44] 
D [14/May/2009:19:27:56 +0200] [Job 44] Closing foomatic-rip.
D [14/May/2009:19:27:56 +0200] PID 5117 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 8192 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Read 7268 bytes of print data...
D [14/May/2009:19:27:56 +0200] [Job 44] Wrote 7268 bytes of print data...
I [14/May/2009:19:28:01 +0200] Saving subscriptions.conf...
I [14/May/2009:19:28:01 +0200] Saving subscriptions.conf...
D [14/May/2009:19:28:01 +0200] PID 5118 (/usr/lib/cups/backend/socket) exited with no errors.
D [14/May/2009:19:28:01 +0200] [Job 44] File 0 is complete.
I [14/May/2009:19:28:01 +0200] [Job 44] Completed successfully.
I [14/May/2009:19:28:01 +0200] Saving subscriptions.conf...
I [14/May/2009:19:28:01 +0200] Saving subscriptions.conf...
D [14/May/2009:19:28:01 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:28:01 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:28:01 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:28:01 +0200] Get-Jobs ipp://localhost/printers/
D [14/May/2009:19:28:01 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:28:01 +0200] cupsdCloseClient: 11
D [14/May/2009:19:28:01 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [14/May/2009:19:28:01 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [14/May/2009:19:28:01 +0200] cupsdAuthorize: No authentication data provided.
D [14/May/2009:19:28:01 +0200] Get-Notifications /
D [14/May/2009:19:28:01 +0200] cupsdIsAuthorized: requesting-user-name="laurent"
D [14/May/2009:19:28:01 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [14/May/2009:19:28:02 +0200] cupsdCloseClient: 11
D [14/May/2009:19:28:02 +0200] [Job 44] Unloading...
D [14/May/2009:19:28:03 +0200] Report: clients=0
D [14/May/2009:19:28:03 +0200] Report: jobs=10
D [14/May/2009:19:28:03 +0200] Report: jobs-active=0
D [14/May/2009:19:28:03 +0200] Report: printers=3
D [14/May/2009:19:28:03 +0200] Report: printers-implicit=0
D [14/May/2009:19:28:03 +0200] Report: stringpool-string-count=1124
D [14/May/2009:19:28:03 +0200] Report: stringpool-alloc-bytes=8944
D [14/May/2009:19:28:03 +0200] Report: stringpool-total-bytes=24872