D [15/Mar/2010:15:40:05 -0400] add_job: requesting-user-name="pavneet"
I [15/Mar/2010:15:40:05 -0400] [Job 118] Adding start banner page "none".
D [15/Mar/2010:15:40:05 -0400] Discarding unused job-created event...
I [15/Mar/2010:15:40:05 -0400] [Job 118] Queued on "HP-LaserJet-1020" by "pavneet".
D [15/Mar/2010:15:40:05 -0400] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/HP-LaserJet-1020) from localhost
D [15/Mar/2010:15:40:05 -0400] cupsdSetBusyState: Dirty files
D [15/Mar/2010:15:40:05 -0400] cupsdReadClient: 13 POST /printers/HP-LaserJet-1020 HTTP/1.1
D [15/Mar/2010:15:40:05 -0400] cupsdSetBusyState: Active clients and dirty files
D [15/Mar/2010:15:40:05 -0400] cupsdAuthorize: No authentication data provided.
D [15/Mar/2010:15:40:05 -0400] cupsdReadClient: 13 1.1 Send-Document 1
D [15/Mar/2010:15:40:05 -0400] Send-Document ipp://localhost:631/printers/HP-LaserJet-1020
D [15/Mar/2010:15:40:05 -0400] cupsdIsAuthorized: requesting-user-name="pavneet"
D [15/Mar/2010:15:40:05 -0400] [Job 118] Auto-typing file...
D [15/Mar/2010:15:40:05 -0400] [Job 118] Request file type is application/pdf.
D [15/Mar/2010:15:40:05 -0400] cupsdMarkDirty(----J-)
I [15/Mar/2010:15:40:05 -0400] [Job 118] File of type application/pdf queued by "pavneet".
I [15/Mar/2010:15:40:05 -0400] [Job 118] Adding end banner page "none".
D [15/Mar/2010:15:40:05 -0400] cupsdMarkDirty(----J-)
D [15/Mar/2010:15:40:05 -0400] cupsdMarkDirty(----J-)
D [15/Mar/2010:15:40:05 -0400] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [15/Mar/2010:15:40:05 -0400] Discarding unused printer-state-changed event...
D [15/Mar/2010:15:40:05 -0400] [Job 118] job-sheets=none,none
D [15/Mar/2010:15:40:05 -0400] [Job 118] argv[0]="HP-LaserJet-1020"
D [15/Mar/2010:15:40:05 -0400] [Job 118] argv[1]="118"
D [15/Mar/2010:15:40:05 -0400] [Job 118] argv[2]="pavneet"
D [15/Mar/2010:15:40:05 -0400] [Job 118] argv[3]="knuth.pdf"
D [15/Mar/2010:15:40:05 -0400] [Job 118] argv[4]="1"
D [15/Mar/2010:15:40:05 -0400] [Job 118] argv[5]="finishings=3 landscape media=letter number-up=1 PageSize=Custom.2.75x6.25in job-uuid=urn:uuid:c52b9a8c-f0fb-3d58-7563-b76448f3a1ea job-originating-host-name=localhost"
D [15/Mar/2010:15:40:05 -0400] [Job 118] argv[6]="/var/spool/cups/d00118-001"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[8]="HOME=/var/spool/cups/tmp"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[10]="SERVER_ADMIN=root@darjiling"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[11]="SOFTWARE=CUPS/1.4.1"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[13]="TZ=America/Toronto"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[14]="USER=root"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[17]="IPP_PORT=631"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[18]="CHARSET=utf-8"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[19]="LANG=en_CA.UTF-8"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[20]="PPD=/etc/cups/ppd/HP-LaserJet-1020.ppd"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[21]="RIP_MAX_CACHE=1012535k"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[22]="CONTENT_TYPE=application/pdf"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[23]="DEVICE_URI=usb://HP/LaserJet%201020"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[24]="PRINTER_INFO=HP LaserJet 1020"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[25]="PRINTER_LOCATION=Papa's Office"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[26]="PRINTER=HP-LaserJet-1020"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[27]="CUPS_FILETYPE=document"
D [15/Mar/2010:15:40:05 -0400] [Job 118] envp[28]="FINAL_CONTENT_TYPE=printer/HP-LaserJet-1020"
I [15/Mar/2010:15:40:05 -0400] [Job 118] Started filter /usr/lib/cups/filter/pdftopdf (PID 7795)
I [15/Mar/2010:15:40:05 -0400] [Job 118] Started filter /usr/lib/cups/filter/foomatic-rip (PID 7796)
I [15/Mar/2010:15:40:05 -0400] [Job 118] Started backend /usr/lib/cups/backend/usb (PID 7797)
D [15/Mar/2010:15:40:05 -0400] Discarding unused job-state-changed event...
D [15/Mar/2010:15:40:05 -0400] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/HP-LaserJet-1020) from localhost
D [15/Mar/2010:15:40:05 -0400] cupsdSetBusyState: Printing jobs and dirty files
D [15/Mar/2010:15:40:05 -0400] cupsdReadClient: 13 WAITING Closing on EOF
D [15/Mar/2010:15:40:05 -0400] cupsdCloseClient: 13
D [15/Mar/2010:15:40:05 -0400] [Job 118] STATE: +connecting-to-device
D [15/Mar/2010:15:40:05 -0400] Discarding unused printer-state-changed event...
D [15/Mar/2010:15:40:05 -0400] [Job 118] Printer using device file "/dev/usblp0"...
D [15/Mar/2010:15:40:05 -0400] [Job 118] STATE: -connecting-to-device
D [15/Mar/2010:15:40:05 -0400] [Job 118] backendRunLoop(print_fd=0, device_fd=5, snmp_fd=-1, addr=(nil), use_bc=1, side_cb=0x2adc2e320670)
D [15/Mar/2010:15:40:05 -0400] Discarding unused printer-state-changed event...
D [15/Mar/2010:15:40:05 -0400] [Job 118] Getting input from file 
D [15/Mar/2010:15:40:05 -0400] [Job 118] foomatic-rip version 4.0.3.215 running...
D [15/Mar/2010:15:40:05 -0400] [Job 118] Parsing PPD file ...
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option PageSize
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option Quality
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option PrinterType
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option ColorMode
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option Resolution
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option ImageableArea
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option PaperDimension
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option InputSlot
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option MediaType
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option Copies
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option Nup
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option NupOrient
D [15/Mar/2010:15:40:05 -0400] [Job 118] Added option Font
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Parameter Summary
D [15/Mar/2010:15:40:05 -0400] [Job 118] -----------------
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Spooler: cups
D [15/Mar/2010:15:40:05 -0400] [Job 118] Printer: HP-LaserJet-1020
D [15/Mar/2010:15:40:05 -0400] [Job 118] Shell: /bin/bash
D [15/Mar/2010:15:40:05 -0400] [Job 118] PPD file: /etc/cups/ppd/HP-LaserJet-1020.ppd
D [15/Mar/2010:15:40:05 -0400] [Job 118] ATTR file: 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Printer model: HP LaserJet 1020 Foomatic/foo2zjs (recommended)
D [15/Mar/2010:15:40:05 -0400] [Job 118] Job title: knuth.pdf
D [15/Mar/2010:15:40:05 -0400] [Job 118] File(s) to be printed:
D [15/Mar/2010:15:40:05 -0400] [Job 118] <STDIN>
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [15/Mar/2010:15:40:05 -0400] [Job 118] Printing system options:
D [15/Mar/2010:15:40:05 -0400] [Job 118] Pondering option 'finishings=3'
D [15/Mar/2010:15:40:05 -0400] [Job 118] Unknown option finishings=3.
D [15/Mar/2010:15:40:05 -0400] [Job 118] Pondering option 'landscape'
D [15/Mar/2010:15:40:05 -0400] [Job 118] Unknown boolean option "landscape".
D [15/Mar/2010:15:40:05 -0400] [Job 118] Pondering option 'media=letter'
D [15/Mar/2010:15:40:05 -0400] [Job 118] Pondering option 'number-up=1'
D [15/Mar/2010:15:40:05 -0400] [Job 118] Unknown option number-up=1.
D [15/Mar/2010:15:40:05 -0400] [Job 118] Pondering option 'job-uuid=urn:uuid:c52b9a8c-f0fb-3d58-7563-b76448f3a1ea'
D [15/Mar/2010:15:40:05 -0400] [Job 118] Unknown option job-uuid=urn:uuid:c52b9a8c-f0fb-3d58-7563-b76448f3a1ea.
D [15/Mar/2010:15:40:05 -0400] [Job 118] Pondering option 'job-originating-host-name=localhost'
D [15/Mar/2010:15:40:05 -0400] [Job 118] Unknown option job-originating-host-name=localhost.
D [15/Mar/2010:15:40:05 -0400] [Job 118] Options from the PPD file:
D [15/Mar/2010:15:40:05 -0400] [Job 118] Pondering option 'PageSize=Custom.2.75x6.25in'
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] ================================================
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] File: <STDIN>
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] ================================================
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Filetype: PDF
D [15/Mar/2010:15:40:05 -0400] [Job 118] Driver does not understand PDF input, converting to PostScript
D [15/Mar/2010:15:40:05 -0400] [Job 118] Storing temporary files in /var/spool/cups/tmp
D [15/Mar/2010:15:40:05 -0400] PID 7795 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [15/Mar/2010:15:40:05 -0400] [Job 118] Starting process "pdf-to-ps" (generation 1)
D [15/Mar/2010:15:40:05 -0400] [Job 118] Filetype: PostScript
D [15/Mar/2010:15:40:05 -0400] [Job 118] Reading PostScript input ...
D [15/Mar/2010:15:40:05 -0400] [Job 118] --> This document is DSC-conforming!
D [15/Mar/2010:15:40:05 -0400] [Job 118] 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 [15/Mar/2010:15:40:05 -0400] [Job 118] Inserting option code into "Prolog" section.
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] -----------
D [15/Mar/2010:15:40:05 -0400] [Job 118] Found: %%BeginProlog
D [15/Mar/2010:15:40:05 -0400] [Job 118] Found: %%EndProlog
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] -----------
D [15/Mar/2010:15:40:05 -0400] [Job 118] Found: %%BeginSetup
D [15/Mar/2010:15:40:05 -0400] [Job 118] Found: %%EndSetup
D [15/Mar/2010:15:40:05 -0400] [Job 118] Inserting PostScript code for CUPS' page accounting
D [15/Mar/2010:15:40:05 -0400] [Job 118] Inserting option code into "Setup" section.
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] -----------
D [15/Mar/2010:15:40:05 -0400] [Job 118] New page: %%Page: 1 1
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Found: %%BeginPageSetup
D [15/Mar/2010:15:40:05 -0400] [Job 118] Inserting option code into "PageSetup" section.
D [15/Mar/2010:15:40:05 -0400] [Job 118] Flushing FIFO.
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Starting renderer with command: "foo2zjs-wrapper -P -z1 -L0    -r1200x600 -pCustom.198x450 -m1 -s7   "
D [15/Mar/2010:15:40:05 -0400] [Job 118] Starting process "kid3" (generation 1)
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] Closing renderer
D [15/Mar/2010:15:40:05 -0400] [Job 118] Starting process "kid4" (generation 2)
D [15/Mar/2010:15:40:05 -0400] [Job 118] Starting process "renderer" (generation 2)
D [15/Mar/2010:15:40:05 -0400] [Job 118] JCL: %-12345X@PJL
D [15/Mar/2010:15:40:05 -0400] [Job 118] <job data> 
D [15/Mar/2010:15:40:05 -0400] [Job 118] 
D [15/Mar/2010:15:40:05 -0400] [Job 118] foo2zjs-wrapper: Custom page size [XY]DIM != 1-99999
D [15/Mar/2010:15:40:05 -0400] [Job 118] renderer exited with status 1
D [15/Mar/2010:15:40:05 -0400] [Job 118] Possible error on renderer command line or PostScript error. Check options.kid3 exited with status 3
D [15/Mar/2010:15:40:05 -0400] [Job 118] Process is dying with "Error closing renderer
D [15/Mar/2010:15:40:05 -0400] [Job 118] ", exit stat 3
D [15/Mar/2010:15:40:05 -0400] [Job 118] Cleaning up...
D [15/Mar/2010:15:40:05 -0400] [Job 118] Killing pdf-to-ps
D [15/Mar/2010:15:40:13 -0400] PID 7796 (/usr/lib/cups/filter/foomatic-rip) stopped with status 3!
D [15/Mar/2010:15:40:13 -0400] PID 7797 (/usr/lib/cups/backend/usb) exited with no errors.
D [15/Mar/2010:15:40:13 -0400] Discarding unused job-state-changed event...
E [15/Mar/2010:15:40:13 -0400] [Job 118] Job stopped due to filter errors; please consult the error_log file for details.
D [15/Mar/2010:15:40:13 -0400] cupsdMarkDirty(----J-)
D [15/Mar/2010:15:40:13 -0400] Discarding unused printer-state-changed event...
D [15/Mar/2010:15:40:14 -0400] [Job 118] Unloading...
I [15/Mar/2010:15:40:26 -0400] Saving job cache file "/var/cache/cups/job.cache"...
D [15/Mar/2010:15:40:26 -0400] cupsdSetBusyState: Not busy