Comment 13 for bug 788631

Revision history for this message
Shane Rice (shane2peru) wrote :

D [06/Jul/2011:10:38:27 -0500] PID 16076 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [06/Jul/2011:10:38:27 -0500] [Job 21] Filetype: PDF
D [06/Jul/2011:10:38:27 -0500] [Job 21] Driver does not understand PDF input, converting to PostScript
D [06/Jul/2011:10:38:27 -0500] [Job 21] Storing temporary files in /var/spool/cups/tmp
D [06/Jul/2011:10:38:27 -0500] PID 16077 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [06/Jul/2011:10:38:27 -0500] [Job 21] Starting process "pdf-to-ps" (generation 1)
D [06/Jul/2011:10:38:27 -0500] [Job 21] Filetype: PostScript
D [06/Jul/2011:10:38:27 -0500] [Job 21] Reading PostScript input ...
D [06/Jul/2011:10:38:27 -0500] [Job 21] --> This document is DSC-conforming!
D [06/Jul/2011:10:38:27 -0500] [Job 21] Job claims to be DSC-conforming, but "%%BeginProlog" was missing before first line with another"%%BeginProlog" comment (is this a TeX/LaTeX/dvips-generated PostScript file?). Assuming start of "Prolog" here.
D [06/Jul/2011:10:38:27 -0500] [Job 21] Inserting option code into "Prolog" section.
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21] -----------
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%BeginProlog
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%EndProlog
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21] -----------
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%BeginSetup
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%EndSetup
D [06/Jul/2011:10:38:27 -0500] [Job 21] Inserting PostScript code for CUPS' page accounting
D [06/Jul/2011:10:38:27 -0500] [Job 21] Inserting option code into "Setup" section.
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21] -----------
D [06/Jul/2011:10:38:27 -0500] [Job 21] New page: %%Page: 1 1
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%BeginPageSetup
D [06/Jul/2011:10:38:27 -0500] [Job 21] Inserting option code into "PageSetup" section.
D [06/Jul/2011:10:38:27 -0500] [Job 21] New page found but previous not printed, print it now.
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%Page: 2 2
D [06/Jul/2011:10:38:27 -0500] [Job 21] --> Output goes directly to the renderer now.
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21] Starting renderer with command: "foo2zjs-wrapper -z1 -P -L0 -r1200x600 -p9 -T3 -m1 -s7 -d1 -n1 "
D [06/Jul/2011:10:38:27 -0500] [Job 21] Starting process "kid3" (generation 1)
D [06/Jul/2011:10:38:27 -0500] [Job 21] Starting process "kid4" (generation 2)
D [06/Jul/2011:10:38:27 -0500] [Job 21] Starting process "renderer" (generation 2)
D [06/Jul/2011:10:38:27 -0500] [Job 21] JCL: 12345X@PJL
D [06/Jul/2011:10:38:27 -0500] [Job 21] <job data>
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21] -----------
D [06/Jul/2011:10:38:27 -0500] [Job 21] New page: %%Page: 2 2
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%Page: 2 2
D [06/Jul/2011:10:38:27 -0500] [Job 21] --> Output goes to the FIFO buffer now.
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21]
D [06/Jul/2011:10:38:27 -0500] [Job 21] Found: %%BeginPageSetup
D [06/Jul/2011:10:38:27 -0500] [Job 21] Inserting option code into "PageSetup" section.
D [06/Jul/2011:10:38:27 -0500] [Job 21] Flushing FIFO.
D [06/Jul/2011:10:38:28 -0500] [Job 21]
D [06/Jul/2011:10:38:28 -0500] [Job 21] Closing renderer
D [06/Jul/2011:10:38:28 -0500] Avahi entry group established for Hewlett-Packard HP LaserJet 1022n @ shanekub
D [06/Jul/2011:10:38:30 -0500] [Job 21] PAGE: 1 1
D [06/Jul/2011:10:38:30 -0500] cupsdMarkDirty(-----S)
D [06/Jul/2011:10:38:30 -0500] [Job 21] STATE: +connecting-to-device
D [06/Jul/2011:10:38:30 -0500] cupsdMarkDirty(-----S)
D [06/Jul/2011:10:38:30 -0500] cupsdAcceptClient: 18 from localhost (Domain)
D [06/Jul/2011:10:38:30 -0500] cupsdReadClient: 18 POST / HTTP/1.1
D [06/Jul/2011:10:38:30 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [06/Jul/2011:10:38:30 -0500] cupsdAuthorize: No authentication data provided.
D [06/Jul/2011:10:38:30 -0500] cupsdReadClient: 18 1.1 Get-Notifications 1
D [06/Jul/2011:10:38:30 -0500] Get-Notifications /
D [06/Jul/2011:10:38:30 -0500] cupsdIsAuthorized: requesting-user-name="shane"
D [06/Jul/2011:10:38:30 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [06/Jul/2011:10:38:30 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [06/Jul/2011:10:38:30 -0500] cupsdReadClient: 18 WAITING Closing on EOF
D [06/Jul/2011:10:38:30 -0500] cupsdCloseClient: 18
D [06/Jul/2011:10:38:30 -0500] [Job 21] STATE: -connecting-to-device
D [06/Jul/2011:10:38:30 -0500] [Job 21] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [06/Jul/2011:10:38:30 -0500] cupsdMarkDirty(-----S)
D [06/Jul/2011:10:38:30 -0500] cupsdAcceptClient: 18 from localhost (Domain)
D [06/Jul/2011:10:38:30 -0500] cupsdReadClient: 18 POST / HTTP/1.1
D [06/Jul/2011:10:38:30 -0500] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [06/Jul/2011:10:38:30 -0500] cupsdAuthorize: No authentication data provided.
D [06/Jul/2011:10:38:30 -0500] cupsdReadClient: 18 1.1 Get-Notifications 1
D [06/Jul/2011:10:38:30 -0500] Get-Notifications /
D [06/Jul/2011:10:38:30 -0500] cupsdIsAuthorized: requesting-user-name="shane"
D [06/Jul/2011:10:38:30 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [06/Jul/2011:10:38:30 -0500] cupsdSetBusyState: Printing jobs and dirty files
D [06/Jul/2011:10:38:30 -0500] cupsdReadClient: 18 WAITING Closing on EOF
D [06/Jul/2011:10:38:30 -0500] cupsdCloseClient: 18
D [06/Jul/2011:10:38:31 -0500] [Job 21] PAGE: 2 1
D [06/Jul/2011:10:38:31 -0500] cupsdMarkDirty(-----S)
D [06/Jul/2011:10:38:32 -0500] [Job 21] renderer exited with status 0
D [06/Jul/2011:10:38:32 -0500] [Job 21] kid4 exited with status 0
D [06/Jul/2011:10:38:32 -0500] [Job 21] kid3 finished
D [06/Jul/2011:10:38:32 -0500] [Job 21] kid3 exited with status 0
D [06/Jul/2011:10:38:32 -0500] [Job 21] pdf-to-ps exited with status 0
D [06/Jul/2011:10:38:32 -0500] [Job 21]
D [06/Jul/2011:10:38:32 -0500] [Job 21] Closing foomatic-rip.
D [06/Jul/2011:10:38:32 -0500] PID 16078 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
I [06/Jul/2011:10:38:40 -0500] [Job 21] ready to print
D [06/Jul/2011:10:38:40 -0500] cupsdMarkDirty(-----S)
D [06/Jul/2011:10:38:40 -0500] cupsdMarkDirty(-----S)
D [06/Jul/2011:10:38:40 -0500] PID 16079 (/usr/lib/cups/backend/hp) exited with no errors.
D [06/Jul/2011:10:38:40 -0500] cupsdMarkDirty(-----S)
I [06/Jul/2011:10:38:40 -0500] [Job 21] Job completed.
D [06/Jul/2011:10:38:40 -0500] cupsdMarkDirty(----J-)
D [06/Jul/2011:10:38:41 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [06/Jul/2011:10:38:41 -0500] [Job 21] Unloading...
D [06/Jul/2011:10:38:41 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [06/Jul/2011:10:38:41 -0500] cupsdSetBusyState: Active clients and dirty files
D [06/Jul/2011:10:38:41 -0500] cupsdAuthorize: No authentication data provided.
D [06/Jul/2011:10:38:41 -0500] cupsdReadClient: 16 1.1 Get-Notifications 1
D [06/Jul/2011:10:38:41 -0500] Get-Notifications /
D [06/Jul/2011:10:38:41 -0500] cupsdIsAuthorized: requesting-user-name="shane"
D [06/Jul/2011:10:38:41 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [06/Jul/2011:10:38:41 -0500] cupsdSetBusyState: Dirty files
D [06/Jul/2011:10:38:41 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [06/Jul/2011:10:38:41 -0500] cupsdCloseClient: 16

Same problem printing through the USB setup. After two print jobs it locks up. I reset the printer, and it re-initiated the printing queue. That is the error log above for the relevant problem.

Shane