D [14/Apr/2007:11:52:13 +0200] Print-Job ipp://localhost/printers/printer
D [14/Apr/2007:11:52:13 +0200] print_job: auto-typing file...
D [14/Apr/2007:11:52:13 +0200] print_job: request file type is application/postscript.
D [14/Apr/2007:11:52:13 +0200] add_job: requesting-user-name="mario"
D [14/Apr/2007:11:52:13 +0200] Adding default job-sheets values "none,none"...
I [14/Apr/2007:11:52:13 +0200] Adding start banner page "none" to job 13.
D [14/Apr/2007:11:52:13 +0200] Discarding unused job-created event...
I [14/Apr/2007:11:52:13 +0200] Adding end banner page "none" to job 13.
I [14/Apr/2007:11:52:13 +0200] Job 13 queued on "printer" by "mario".
D [14/Apr/2007:11:52:13 +0200] Job 13 hold_until = 0
D [14/Apr/2007:11:52:13 +0200] Discarding unused printer-state-changed event...
D [14/Apr/2007:11:52:13 +0200] job-sheets=none,none
D [14/Apr/2007:11:52:13 +0200] banner_page = 0
D [14/Apr/2007:11:52:13 +0200] [Job 13] argv[0]="printer"
D [14/Apr/2007:11:52:13 +0200] [Job 13] argv[1]="13"
D [14/Apr/2007:11:52:13 +0200] [Job 13] argv[2]="mario"
D [14/Apr/2007:11:52:13 +0200] [Job 13] argv[3]=""
D [14/Apr/2007:11:52:13 +0200] [Job 13] argv[4]="1"
D [14/Apr/2007:11:52:13 +0200] [Job 13] argv[5]="job-uuid=urn:uuid:1e32a74c-4fdf-3c83-5a32-6fc2d0ffffd9"
D [14/Apr/2007:11:52:13 +0200] [Job 13] argv[6]="/var/spool/cups/d00013-001"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[2]="CUPS_DOCROOT=/usr/share/cups/html"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[5]="CUPS_SERVERBIN=/usr/libexec/cups"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[8]="PATH=/usr/libexec/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[9]="SERVER_ADMIN=root@master.lixnet.intra"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[10]="SOFTWARE=CUPS/1.2.6"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[12]="USER=root"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[13]="CUPS_SERVER=/var/run/cups/cups.sock"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[14]="CUPS_ENCRYPTION=IfRequested"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[15]="IPP_PORT=631"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[16]="CHARSET=utf-8"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[17]="LANG=de_DE"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[18]="PPD=/etc/cups/ppd/printer.ppd"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[19]="RIP_MAX_CACHE=8m"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[20]="CONTENT_TYPE=application/postscript"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[21]="DEVICE_URI=socket://localhost"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[22]="PRINTER=printer"
D [14/Apr/2007:11:52:13 +0200] [Job 13] envp[23]="FINAL_CONTENT_TYPE=printer/printer"
I [14/Apr/2007:11:52:13 +0200] Started filter /usr/libexec/cups/filter/pstops (PID 7433) for job 13.
I [14/Apr/2007:11:52:13 +0200] Started filter /usr/libexec/cups/filter/foomatic-rip (PID 7434) for job 13.
I [14/Apr/2007:11:52:13 +0200] Started backend /usr/libexec/cups/backend/socket (PID 7435) for job 13.
D [14/Apr/2007:11:52:13 +0200] Discarding unused job-state event...
D [14/Apr/2007:11:52:13 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [14/Apr/2007:11:52:13 +0200] Discarding unused printer-state-changed event...
D [14/Apr/2007:11:52:13 +0200] [Job 13] Page = 595x842; 0,0 to 595,842
D [14/Apr/2007:11:52:13 +0200] [Job 13] slow_collate=0, slow_duplex=0, slow_order=0
D [14/Apr/2007:11:52:13 +0200] [Job 13] Before copy_comments - %!PS-Adobe-3.0
D [14/Apr/2007:11:52:13 +0200] [Job 13] %!PS-Adobe-3.0
D [14/Apr/2007:11:52:13 +0200] [Job 13] %%Creator: xpdf/pdftops 3.00
D [14/Apr/2007:11:52:13 +0200] [Job 13] %%LanguageLevel: 2
D [14/Apr/2007:11:52:13 +0200] [Job 13] %%DocumentSuppliedResources: (atend)
D [14/Apr/2007:11:52:13 +0200] [Job 13] %%DocumentMedia: plain 595 842 0 () ()
D [14/Apr/2007:11:52:13 +0200] [Job 13] %%BoundingBox: 0 0 595 842
D [14/Apr/2007:11:52:13 +0200] [Job 13] %%Pages: 4
D [14/Apr/2007:11:52:13 +0200] [Job 13] %%EndComments
D [14/Apr/2007:11:52:13 +0200] [Job 13] Before copy_prolog - %%BeginDefaults
D [14/Apr/2007:11:52:13 +0200] [Job 13] Before copy_setup - %%BeginSetup
D [14/Apr/2007:11:52:13 +0200] [Job 13] perl: warning: Setting locale failed.
D [14/Apr/2007:11:52:13 +0200] [Job 13] perl: warning: Please check that your locale settings:
D [14/Apr/2007:11:52:13 +0200] [Job 13] LANGUAGE = (unset),
D [14/Apr/2007:11:52:13 +0200] [Job 13] LC_ALL = (unset),
D [14/Apr/2007:11:52:13 +0200] [Job 13] LANG = "de_DE"
D [14/Apr/2007:11:52:13 +0200] [Job 13] are supported and installed on your system.
D [14/Apr/2007:11:52:13 +0200] [Job 13] perl: warning: Falling back to the standard locale ("C").
D [14/Apr/2007:11:52:13 +0200] [Job 13] foomatic-rip version $Revision$ running...
D [14/Apr/2007:11:52:13 +0200] [Job 13] Parsing PPD file ...
D [14/Apr/2007:11:52:13 +0200] [Job 13] *cupsFilter: "application/vnd.cups-postscript 0 foomatic-rip"
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option ColorSpace
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option PageSize
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option PageRegion
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option ImageableArea
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option PaperDimension
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option ColorMode
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option BlackCorrect
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option Depletion
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option Passes
D [14/Apr/2007:11:52:13 +0200] [Job 13] Added option Font
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] Parameter Summary
D [14/Apr/2007:11:52:13 +0200] [Job 13] -----------------
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] Spooler: cups
D [14/Apr/2007:11:52:13 +0200] [Job 13] Printer: printer
D [14/Apr/2007:11:52:13 +0200] [Job 13] Shell: /bin/sh
D [14/Apr/2007:11:52:13 +0200] [Job 13] PPD file: /etc/cups/ppd/printer.ppd
D [14/Apr/2007:11:52:13 +0200] [Job 13] ATTR file: 
D [14/Apr/2007:11:52:13 +0200] [Job 13] Printer model: HP DeskJet 930C Foomatic/cdj550
D [14/Apr/2007:11:52:13 +0200] [Job 13] Job title: 
D [14/Apr/2007:11:52:13 +0200] [Job 13] File(s) to be printed: 
D [14/Apr/2007:11:52:13 +0200] [Job 13] <STDIN>
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] GhostScript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [14/Apr/2007:11:52:13 +0200] [Job 13] Pondering option 'job-uuid=urn:uuid:1e32a74c-4fdf-3c83-5a32-6fc2d0ffffd9'
D [14/Apr/2007:11:52:13 +0200] [Job 13] Unknown option job-uuid=urn:uuid:1e32a74c-4fdf-3c83-5a32-6fc2d0ffffd9.
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] ================================================
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] File: <STDIN>
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] ================================================
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] Reading PostScript input ...
D [14/Apr/2007:11:52:13 +0200] [Job 13] --> This document is DSC-conforming!
D [14/Apr/2007:11:52:13 +0200] [Job 13] Job claims to be DSC-conforming, but "%%BeginProlog" was missing before first line with another "%%Begin..." comment (is this a TeX/LaTeX/dvips-generated PostScript file?). Assuming start of "Prolog" here.
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] -----------
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginProlog
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%EndProlog
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] -----------
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginSetup
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginFeature: *PageSize A4
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: PageSize=A4 --> Option will be set by PostScript interpreter
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginFeature: *ColorMode NormalColor
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: ColorMode=NormalColor --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %% FoomaticRIPOptionSetting: ColorMode=NormalColor
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: ColorMode=NormalColor --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginFeature: *BlackCorrect 4
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: BlackCorrect=4 --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %% FoomaticRIPOptionSetting: BlackCorrect=4
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: BlackCorrect=4 --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginFeature: *Depletion Default
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: Depletion=Default --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %% FoomaticRIPOptionSetting: Depletion=Default
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: Depletion=Default --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginFeature: *Passes Default
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: Passes=Default --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %% FoomaticRIPOptionSetting: Passes=Default
D [14/Apr/2007:11:52:13 +0200] [Job 13] Option: Passes=Default --> Setting option
D [14/Apr/2007:11:52:13 +0200] [Job 13] Before page loop - %%Page: 1 1
D [14/Apr/2007:11:52:13 +0200] [Job 13] Copying page 1...
D [14/Apr/2007:11:52:13 +0200] [Job 13] pagew = 595.0, pagel = 842.0
D [14/Apr/2007:11:52:13 +0200] [Job 13] bboxw = 595, bboxl = 842
D [14/Apr/2007:11:52:13 +0200] [Job 13] PageLeft = 0.0, PageRight = 595.0
D [14/Apr/2007:11:52:13 +0200] [Job 13] PageTop = 842.0, PageBottom = 0.0
D [14/Apr/2007:11:52:13 +0200] [Job 13] PageWidth = 595.0, PageLength = 842.0
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%EndSetup
D [14/Apr/2007:11:52:13 +0200] [Job 13] Inserting PostScript code for CUPS' page accounting
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] -----------
D [14/Apr/2007:11:52:13 +0200] [Job 13] New page:  1 1
D [14/Apr/2007:11:52:13 +0200] [Job 13] Inserting option code into "PageSetup" section.
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%BeginPageSetup
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found: %%EndPageSetup
D [14/Apr/2007:11:52:13 +0200] [Job 13] End of page header
D [14/Apr/2007:11:52:13 +0200] [Job 13] Stopping search for page header options
D [14/Apr/2007:11:52:13 +0200] [Job 13] Found:
D [14/Apr/2007:11:52:13 +0200] [Job 13] 0
D [14/Apr/2007:11:52:13 +0200] [Job 13] --> Output goes directly to the renderer now.
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] Starting renderer
D [14/Apr/2007:11:52:13 +0200] [Job 13] JCL: <job data> 
D [14/Apr/2007:11:52:13 +0200] [Job 13] 
D [14/Apr/2007:11:52:13 +0200] [Job 13] renderer PID kid4=7440
D [14/Apr/2007:11:52:13 +0200] [Job 13] renderer command: gs -q -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -r300x300 -sDEVICE=cdj550 -dBitsPerPixel=3 -dBlackCorrect=4 -sOutputFile=- -
D [14/Apr/2007:11:52:13 +0200] [Job 13] perl: warning: Setting locale failed.
D [14/Apr/2007:11:52:13 +0200] [Job 13] perl: warning: Please check that your locale settings:
D [14/Apr/2007:11:52:13 +0200] [Job 13] LANGUAGE = (unset),
D [14/Apr/2007:11:52:13 +0200] [Job 13] LC_ALL = (unset),
D [14/Apr/2007:11:52:13 +0200] [Job 13] LANG = "de_DE"
D [14/Apr/2007:11:52:13 +0200] [Job 13] are supported and installed on your system.
D [14/Apr/2007:11:52:13 +0200] [Job 13] perl: warning: Falling back to the standard locale ("C").
D [14/Apr/2007:11:52:13 +0200] [Job 13] foomatic-gswrapper: gs '-dBATCH' '-dPARANOIDSAFER' '-dQUIET' '-dNOPAUSE' '-r300x300' '-sDEVICE=cdj550' '-dBitsPerPixel=3' '-dBlackCorrect=4' '-sOutputFile=/dev/fd/3' '/dev/fd/0' 3>&1 1>&2
D [14/Apr/2007:11:52:17 +0200] cupsdReadClient: 8 POST / HTTP/1.1
D [14/Apr/2007:11:52:17 +0200] cupsdAuthorize: No authentication data provided.
D [14/Apr/2007:11:52:17 +0200] CUPS-Get-Default
D [14/Apr/2007:11:52:17 +0200] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [14/Apr/2007:11:52:17 +0200] cupsdReadClient: 8 POST / HTTP/1.1
D [14/Apr/2007:11:52:17 +0200] cupsdAuthorize: No authentication data provided.
D [14/Apr/2007:11:52:17 +0200] CUPS-Get-Printers
D [14/Apr/2007:11:52:17 +0200] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [14/Apr/2007:11:52:18 +0200] Discarding unused printer-state-changed event...
D [14/Apr/2007:11:52:22 +0200] cupsdReadClient: 8 POST / HTTP/1.1
D [14/Apr/2007:11:52:22 +0200] cupsdAuthorize: No authentication data provided.
D [14/Apr/2007:11:52:22 +0200] CUPS-Get-Default
D [14/Apr/2007:11:52:22 +0200] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)