D [16/Mar/2011:08:05:57 -0500] cupsdNetIFUpdate: "lo" = localhost:631
D [16/Mar/2011:08:05:57 -0500] cupsdNetIFUpdate: "eth0" = fe80::21f:d0ff:fe91:4d4%eth0:631
D [16/Mar/2011:08:05:57 -0500] Report: clients=0
D [16/Mar/2011:08:05:57 -0500] Report: jobs=499
D [16/Mar/2011:08:05:57 -0500] Report: jobs-active=0
D [16/Mar/2011:08:05:57 -0500] Report: printers=1
D [16/Mar/2011:08:05:57 -0500] Report: printers-implicit=0
D [16/Mar/2011:08:05:57 -0500] Report: stringpool-string-count=1261
D [16/Mar/2011:08:05:57 -0500] Report: stringpool-alloc-bytes=6336
D [16/Mar/2011:08:05:57 -0500] Report: stringpool-total-bytes=20176
D [16/Mar/2011:08:06:32 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:32 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:32 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:06:32 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:32 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 12 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:32 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:32 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:32 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:32 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:32 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 13 GET /printers/Deskjet_D1600.ppd HTTP/1.1
D [16/Mar/2011:08:06:32 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:32 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:32 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [16/Mar/2011:08:06:32 -0500] cupsdAcceptClient: 15 from localhost (Domain)
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [16/Mar/2011:08:06:32 -0500] cupsdCloseClient: 14
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 15 POST / HTTP/1.1
D [16/Mar/2011:08:06:32 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:32 -0500] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:32 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:32 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:32 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 15 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 15
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:33 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:33 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:33 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:33 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:33 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:33 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:33 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:33 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:33 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:33 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:33 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:33 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:33 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:33 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:33 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:33 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:33 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:33 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:34 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:34 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:34 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:34 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:34 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:34 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:34 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:34 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:34 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:34 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:34 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:34 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:34 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:34 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:34 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:34 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:34 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:34 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:35 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:35 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:35 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:35 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:35 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:35 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:35 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:35 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:35 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:35 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:35 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:35 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:35 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:35 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:35 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:35 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:35 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:35 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:36 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:36 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:36 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:36 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:36 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:36 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:36 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:36 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:36 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:36 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:36 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:36 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:36 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:36 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:36 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:36 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:36 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:36 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:37 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:37 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:37 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:37 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:37 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:37 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:37 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:37 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:37 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:37 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:37 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:37 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:37 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:37 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:37 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:37 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:37 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:37 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:38 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:38 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:38 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:38 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:38 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:38 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:38 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:38 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:38 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:38 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:38 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:38 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:38 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:38 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:38 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:38 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:38 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:38 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:39 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:39 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:39 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:39 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:39 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:39 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:39 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:39 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:39 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:39 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:39 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:39 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:39 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:40 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:40 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:40 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:40 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:40 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:40 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:40 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:40 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:40 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:40 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:40 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:40 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:40 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:41 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:41 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:41 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:41 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:41 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:41 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:41 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:41 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:41 -0500] cupsdAcceptClient: 13 from localhost (Domain)
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:41 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 13 POST / HTTP/1.1
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:41 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [16/Mar/2011:08:06:41 -0500] CUPS-Get-Printers
D [16/Mar/2011:08:06:41 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Not busy
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 13 WAITING Closing on EOF
D [16/Mar/2011:08:06:41 -0500] cupsdCloseClient: 13
D [16/Mar/2011:08:06:41 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 POST /printers/Deskjet_D1600 HTTP/1.1
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients
D [16/Mar/2011:08:06:41 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 1.1 Print-Job 1
D [16/Mar/2011:08:06:41 -0500] Print-Job ipp://localhost:631/printers/Deskjet_D1600
D [16/Mar/2011:08:06:41 -0500] [Job ???] Auto-typing file...
I [16/Mar/2011:08:06:41 -0500] [Job ???] Request file type is application/pdf.
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(----J-)
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients and dirty files
D [16/Mar/2011:08:06:41 -0500] add_job: requesting-user-name="jamieson"
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Adding start banner page "none".
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(----J-)
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Adding end banner page "none".
I [16/Mar/2011:08:06:41 -0500] [Job 1416] File of type application/pdf queued by "jamieson".
D [16/Mar/2011:08:06:41 -0500] [Job 1416] hold_until=0
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Queued on "Deskjet_D1600" by "jamieson".
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(----J-)
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:41 -0500] [Job 1416] job-sheets=none,none
D [16/Mar/2011:08:06:41 -0500] [Job 1416] argv[0]="Deskjet_D1600"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] argv[1]="1416"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] argv[2]="jamieson"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] argv[3]="Doc Delivery"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] argv[4]="1"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] argv[5]="OutputMode=DraftGray PageSize=Letter MediaType=Plain number-up=1 InputSlot=Auto job-uuid=urn:uuid:22aa13e8-900e-3ecc-5f74-a23486ab8ca7 job-originating-host-name=localhost"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] argv[6]="/var/spool/cups/d01416-001"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[8]="HOME=/var/spool/cups/tmp"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[10]="SERVER_ADMIN=root@Jubuntu"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[11]="SOFTWARE=CUPS/1.4.3"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[13]="TZ=America/Chicago"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[14]="USER=root"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[17]="IPP_PORT=631"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[18]="CHARSET=utf-8"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[19]="LANG=en_US.UTF-8"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[20]="PPD=/etc/cups/ppd/Deskjet_D1600.ppd"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[21]="RIP_MAX_CACHE=1014274k"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[22]="CONTENT_TYPE=application/pdf"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[23]="DEVICE_URI=hp:/usb/Deskjet_D1600_series?serial=CN05FCB4CJ05CT"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[24]="PRINTER_INFO=Deskjet_D1600"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[25]="PRINTER_LOCATION="
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[26]="PRINTER=Deskjet_D1600"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[27]="CUPS_FILETYPE=document"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[28]="FINAL_CONTENT_TYPE=printer/Deskjet_D1600"
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Started filter /usr/lib/cups/filter/pdftopdf (PID 3831)
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Started filter /usr/lib/cups/filter/pdftoraster (PID 3832)
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Started filter /usr/lib/cups/filter/hpcups (PID 3833)
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Started backend /usr/lib/cups/backend/hp (PID 3834)
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:41 -0500] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/Deskjet_D1600) from localhost
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:41 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -I/usr/share/cups/fonts -sMediaType=Plain -sOutputType=-1 -r600x600 -dMediaPosition=7 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=1 -dcupsRowStep=2 -dcupsInteger0=2 -scupsString0=PlainDraftGrayK -scupsPageSizeName=Letter -c -f -_
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[8]="HOME=/var/spool/cups/tmp"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[10]="SERVER_ADMIN=root@Jubuntu"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[11]="SOFTWARE=CUPS/1.4.3"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[12]="TZ=America/Chicago"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[13]="USER=root"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[16]="IPP_PORT=631"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[17]="CHARSET=utf-8"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[18]="LANG=en_US.UTF-8"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[19]="PPD=/etc/cups/ppd/Deskjet_D1600.ppd"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[20]="RIP_MAX_CACHE=1014274k"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[21]="CONTENT_TYPE=application/pdf"
D [16/Mar/2011:08:06:41 -0500] PID 3831 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[22]="DEVICE_URI=hp:/usb/Deskjet_D1600_series?serial=CN05FCB4CJ05CT"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[23]="PRINTER_INFO=Deskjet_D1600"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[24]="PRINTER_LOCATION="
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[25]="PRINTER=Deskjet_D1600"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[26]="CUPS_FILETYPE=document"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] envp[27]="FINAL_CONTENT_TYPE=printer/Deskjet_D1600"
D [16/Mar/2011:08:06:41 -0500] [Job 1416] num_components = 1, depth = 1
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsColorSpace = 3, cupsColorOrder = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsBitsPerPixel = 1, cupsBitsPerColor = 1
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_gray = 1, dither_grays = 2
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_color = 0, dither_colors = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Updating PageSize to [612 792]...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting initial media size, [612 792] = 5100x6600 pixels...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting MediaType to "Plain"...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting OutputType to "-1"...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting MediaPosition to 7...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting cupsBitsPerColor to 8...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting cupsColorOrder to 0...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting cupsColorSpace to 1...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting cupsRowStep to 2...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting cupsInteger0 to 2...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting cupsString0 to "PlainDraftGrayK"...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting cupsPageSizeName to "Letter"...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting initial media size, [612 792] = 5100x6600 pixels...
I [16/Mar/2011:08:06:41 -0500] [Job 1416] Processing page 1...
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:41 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:41 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting LeadingEdge to 0...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Updating PageSize to [612 792]...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] size = Letter
D [16/Mar/2011:08:06:41 -0500] [Job 1416] margins[] = [ 0.125000 0.500000 0.125000 0.069000 ]
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting LeadingEdge to 0...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Setting LeadingEdge to 0...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:41 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:41 -0500] [Job 1416] Updating PageSize to [612 792]...
D [16/Mar/2011:08:06:41 -0500] [Job 1416] size = Letter
D [16/Mar/2011:08:06:41 -0500] [Job 1416] margins[] = [ 0.125000 0.500000 0.125000 0.069000 ]
D [16/Mar/2011:08:06:41 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 1.1 Get-Jobs 1
D [16/Mar/2011:08:06:41 -0500] Get-Jobs ipp://localhost/printers/
D [16/Mar/2011:08:06:41 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:41 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:41 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 1.1 Get-Notifications 1
D [16/Mar/2011:08:06:41 -0500] Get-Notifications /
D [16/Mar/2011:08:06:41 -0500] cupsdIsAuthorized: requesting-user-name="jamieson"
D [16/Mar/2011:08:06:41 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 1.1 Get-Job-Attributes 1
D [16/Mar/2011:08:06:41 -0500] Get-Job-Attributes ipp://localhost/jobs/1416
D [16/Mar/2011:08:06:41 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/1416) from localhost
D [16/Mar/2011:08:06:41 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:41 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:41 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:42 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:42 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:42 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:42 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:42 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:42 -0500] [Job 1416] cups_print_chunked: xflip = 0, yflip = 0, height = 6259
D [16/Mar/2011:08:06:42 -0500] [Job 1416] STATE: +connecting-to-device
D [16/Mar/2011:08:06:42 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:42 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:42 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:06:42 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:42 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:42 -0500] cupsdReadClient: 12 1.1 Get-Jobs 1
D [16/Mar/2011:08:06:42 -0500] Get-Jobs ipp://localhost/printers/
D [16/Mar/2011:08:06:42 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [16/Mar/2011:08:06:42 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:42 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:06:42 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:06:42 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:06:42 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:06:42 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:42 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:42 -0500] cupsdReadClient: 12 1.1 Get-Notifications 1
D [16/Mar/2011:08:06:42 -0500] Get-Notifications /
D [16/Mar/2011:08:06:42 -0500] cupsdIsAuthorized: requesting-user-name="jamieson"
D [16/Mar/2011:08:06:42 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [16/Mar/2011:08:06:42 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:42 -0500] [Job 1416] PAGE: 1 1STATE: -connecting-to-device
D [16/Mar/2011:08:06:42 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:42 -0500] [Job 1416] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
I [16/Mar/2011:08:06:59 -0500] [Job 1416] Processing page 2...
D [16/Mar/2011:08:06:59 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:59 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:06:59 -0500] Report: clients=1
D [16/Mar/2011:08:06:59 -0500] Report: jobs=499
D [16/Mar/2011:08:06:59 -0500] Report: jobs-active=1
D [16/Mar/2011:08:06:59 -0500] Report: printers=1
D [16/Mar/2011:08:06:59 -0500] Report: printers-implicit=0
D [16/Mar/2011:08:06:59 -0500] Report: stringpool-string-count=1512
D [16/Mar/2011:08:06:59 -0500] Report: stringpool-alloc-bytes=8128
D [16/Mar/2011:08:06:59 -0500] Report: stringpool-total-bytes=25424
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting AdvanceDistance to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting AdvanceMedia to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting Collate to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting CutMedia to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting Duplex to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting Jog to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting LeadingEdge to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting Margins to 0 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting MirrorPrint to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting NegativePrint to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting OutputFaceUp to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting Separations to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting TraySwitch to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting Tumble to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsMediaType to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsBitsPerColor to 8...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsColorOrder to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsColorSpace to 1...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsCompression to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsRowCount to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsRowFeed to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsRowStep to 2...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsBorderlessScalingFactor to 1.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger0 to 2...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger1 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger2 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger3 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger4 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger5 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger6 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger7 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger8 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger9 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger10 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger11 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger12 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger13 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger14 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsInteger15 to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal0 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal1 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal2 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal3 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal4 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal5 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal6 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal7 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal8 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal9 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal10 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal11 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal12 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal13 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal14 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsReal15 to 0.0000...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString0 to "PlainDraftGrayK"...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString1 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString2 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString3 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString4 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString5 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString6 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString7 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString8 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString9 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString10 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString11 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString12 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString13 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString14 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsString15 to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsMarkerType to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsRenderingIntent to ""...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting cupsPageSizeName to "Letter"...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:59 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:59 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:59 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:59 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Updating PageSize to [612 792]...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] size = Letter
D [16/Mar/2011:08:06:59 -0500] [Job 1416] margins[] = [ 0.125000 0.500000 0.125000 0.069000 ]
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting LeadingEdge to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:59 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:59 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:59 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:59 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Setting LeadingEdge to 0...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] num_components = 3, depth = 24
D [16/Mar/2011:08:06:59 -0500] [Job 1416] cupsColorSpace = 1, cupsColorOrder = 0
D [16/Mar/2011:08:06:59 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsBitsPerColor = 8
D [16/Mar/2011:08:06:59 -0500] [Job 1416] max_gray = 0, dither_grays = 0
D [16/Mar/2011:08:06:59 -0500] [Job 1416] max_color = 255, dither_colors = 256
D [16/Mar/2011:08:06:59 -0500] [Job 1416] Updating PageSize to [612 792]...
D [16/Mar/2011:08:06:59 -0500] [Job 1416] size = Letter
D [16/Mar/2011:08:06:59 -0500] [Job 1416] margins[] = [ 0.125000 0.500000 0.125000 0.069000 ]
D [16/Mar/2011:08:06:59 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [16/Mar/2011:08:06:59 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [16/Mar/2011:08:06:59 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:59 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:59 -0500] cupsdReadClient: 17 1.1 Get-Jobs 1
D [16/Mar/2011:08:06:59 -0500] Get-Jobs ipp://localhost/printers/
D [16/Mar/2011:08:06:59 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [16/Mar/2011:08:06:59 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:59 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [16/Mar/2011:08:06:59 -0500] cupsdCloseClient: 17
D [16/Mar/2011:08:06:59 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [16/Mar/2011:08:06:59 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [16/Mar/2011:08:06:59 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [16/Mar/2011:08:06:59 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:06:59 -0500] cupsdReadClient: 17 1.1 Get-Notifications 1
D [16/Mar/2011:08:06:59 -0500] Get-Notifications /
D [16/Mar/2011:08:06:59 -0500] cupsdIsAuthorized: requesting-user-name="jamieson"
D [16/Mar/2011:08:06:59 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [16/Mar/2011:08:06:59 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [16/Mar/2011:08:06:59 -0500] [Job 1416] cups_print_chunked: xflip = 0, yflip = 0, height = 6259
E [16/Mar/2011:08:06:59 -0500] PID 3833 (/usr/lib/cups/filter/hpcups) crashed on signal 11!
D [16/Mar/2011:08:06:59 -0500] PID 3832 (/usr/lib/cups/filter/pdftoraster) stopped with status 1!
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PAGE: 2 1INFO: ready to print
D [16/Mar/2011:08:07:09 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:07:09 -0500] PID 3834 (/usr/lib/cups/backend/hp) exited with no errors.
D [16/Mar/2011:08:07:09 -0500] cupsdMarkDirty(-----S)
E [16/Mar/2011:08:07:09 -0500] [Job 1416] Job stopped due to filter errors; please consult the error_log file for details.
D [16/Mar/2011:08:07:09 -0500] cupsdMarkDirty(----J-)
D [16/Mar/2011:08:07:09 -0500] cupsdMarkDirty(-----S)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] The following messages were recorded from 08:06:41 AM to 08:06:59 AM
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = (nil)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = (nil)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 94972823735663329280.000 0.000 45658847620607508480.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_open(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_space_params(0x7f0460a4c068, 0x7fffe5b69d70)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cache_size = 1038616576
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e20)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -0.000 6600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69dd0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -0.000 6600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e50)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -0.000 6600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69d10)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -0.000 6600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e50)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -0.000 6600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e00)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 5100, height = 6600
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -0.000 6600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Tumble = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->page = 1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD->flip_duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] (4) Flip: X=0 Y=0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.cupsPageSizeName = Letter
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocating memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_space_params(0x7f0460a4c068, 0x7fffe5b69a60)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cache_size = 1038616576
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocated memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.125 0.500 0.125 0.069 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69d60)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69d10)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e20)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69dd0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e60)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e50)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b69de0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69d10)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69e00)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Tumble = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->page = 1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD->flip_duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] (4) Flip: X=0 Y=0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.cupsPageSizeName = Letter
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocating memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_space_params(0x7f0460a4c068, 0x7fffe5b6a010)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cache_size = 1038616576
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocated memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.125 0.500 0.125 0.069 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a3d0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a380)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a410)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a400)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a2c0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a3b0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a3b0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.000 0.000 110871234107722956800.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.000 0.000 0.000 0.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_print_pages(0x7f0460a4c068, 0x7f045fe21780, 1)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsWidth = 4950, cupsBytesPerLine = 14850, srcbytes = 14850
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cupsWidth = 4950, cupsHeight = 6259, cupsBytesPerLine = 14850
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Tumble = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->page = 1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a3b0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Tumble = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->page = 2
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD->flip_duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] (4) Flip: X=0 Y=0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.cupsPageSizeName = Letter
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocating memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_space_params(0x7f0460a4c068, 0x7fffe5b6a010)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cache_size = 1038616576
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocated memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.125 0.500 0.125 0.069 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_put_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_set_color_info(0x7f0460a4c068)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[0] = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->EncodeLUT[65535] = 255
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Tumble = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->page = 2
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD->flip_duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] (4) Flip: X=0 Y=0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.cupsPageSizeName = Letter
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocating memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_space_params(0x7f0460a4c068, 0x7fffe5b6a010)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cache_size = 1038616576
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Reallocated memory, [612 792] = 4950x6259 pixels...
D [16/Mar/2011:08:07:09 -0500] [Job 1416] ppd = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612.000 792.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] margins = [ 0.125 0.500 0.125 0.069 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWResolution = [ 600.000 600.000 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a3d0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a380)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a410)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a400)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a2c0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a3b0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b6a3b0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_matrix(0x7f0460a4c068, 0x7fffe5b69bc0)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Portrait matrix: XX=+1 XY=0 YX=0 YY=-1
D [16/Mar/2011:08:07:09 -0500] [Job 1416] width = 4950, height = 6259
D [16/Mar/2011:08:07:09 -0500] [Job 1416] PageSize = [ 612 792 ], HWResolution = [ 600 600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] HWMargins = [ 9.000 36.000 9.000 4.968 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] matrix = [ 8.333 0.000 0.000 -8.333 -75.000 6558.600 ]
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_get_params(0x7f0460a4c068, 0x7fffe5b6a390)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] before gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] after gdev_prn_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] Leaving cups_get_params()
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups_print_pages(0x7f0460a4c068, 0x7f045fe21780, 1)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cupsBitsPerPixel = 24, cupsWidth = 4950, cupsBytesPerLine = 14850, srcbytes = 14850
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cupsWidth = 4950, cupsHeight = 6259, cupsBytesPerLine = 14850
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Duplex = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->header.Tumble = 0
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->page = 2
D [16/Mar/2011:08:07:09 -0500] [Job 1416] cups->PPD = 0xc54610
D [16/Mar/2011:08:07:09 -0500] [Job 1416] End of messages
D [16/Mar/2011:08:07:09 -0500] [Job 1416] printer-state=3(idle)
D [16/Mar/2011:08:07:09 -0500] [Job 1416] printer-state-message="/usr/lib/cups/filter/hpcups failed"
D [16/Mar/2011:08:07:09 -0500] [Job 1416] printer-state-reasons=none
D [16/Mar/2011:08:07:09 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Active clients and dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 14 1.1 Get-Jobs 1
D [16/Mar/2011:08:07:09 -0500] Get-Jobs ipp://localhost/printers/
D [16/Mar/2011:08:07:09 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [16/Mar/2011:08:07:09 -0500] cupsdCloseClient: 14
D [16/Mar/2011:08:07:09 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Active clients and dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 14 1.1 Get-Notifications 1
D [16/Mar/2011:08:07:09 -0500] Get-Notifications /
D [16/Mar/2011:08:07:09 -0500] cupsdIsAuthorized: requesting-user-name="jamieson"
D [16/Mar/2011:08:07:09 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [16/Mar/2011:08:07:09 -0500] cupsdCloseClient: 17
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [16/Mar/2011:08:07:09 -0500] cupsdCloseClient: 12
D [16/Mar/2011:08:07:09 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Active clients and dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 12 1.1 Get-Printer-Attributes 1
D [16/Mar/2011:08:07:09 -0500] Get-Printer-Attributes ipp://Jubuntu:631/printers/Deskjet_D1600
D [16/Mar/2011:08:07:09 -0500] Returning IPP successful-ok for Get-Printer-Attributes (ipp://Jubuntu:631/printers/Deskjet_D1600) from localhost
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Active clients and dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdAuthorize: No authentication data provided.
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 12 1.1 Get-Job-Attributes 1
D [16/Mar/2011:08:07:09 -0500] Get-Job-Attributes ipp://localhost/jobs/1416
D [16/Mar/2011:08:07:09 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/1416) from localhost
D [16/Mar/2011:08:07:09 -0500] cupsdSetBusyState: Dirty files
D [16/Mar/2011:08:07:09 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [16/Mar/2011:08:07:09 -0500] cupsdCloseClient: 14
D [16/Mar/2011:08:07:10 -0500] [Job 1416] Unloading...
D [16/Mar/2011:08:07:10 -0500] cupsdNetIFUpdate: "lo" = localhost:631
D [16/Mar/2011:08:07:10 -0500] cupsdNetIFUpdate: "eth0" = 216.170.205.242:631
D [16/Mar/2011:08:07:10 -0500] cupsdNetIFUpdate: "lo" = localhost:631
D [16/Mar/2011:08:07:10 -0500] cupsdNetIFUpdate: "eth0" = fe80::21f:d0ff:fe91:4d4%eth0:631
I [16/Mar/2011:08:07:12 -0500] Saving job cache file "/var/cache/cups/job.cache"...
I [16/Mar/2011:08:07:12 -0500] Saving subscriptions.conf...
D [16/Mar/2011:08:07:12 -0500] cupsdSetBusyState: Not busy