>
> Does it happen before anything prints, or half-way through a job? Are
> there any useful messages in /var/log/cups/error_log?
It prints out 90 pages or so, and than just stops. In some cases I got
more than 100 pages printed out.
Here is /var/log/cups/error_log (in debug mode):
D [26/Feb/2008:13:47:20 +0100] AcceptClient: 8 from localhost:631.
D [26/Feb/2008:13:47:20 +0100] ReadClient: 8 POST / HTTP/1.1
D [26/Feb/2008:13:47:20 +0100] ProcessIPPRequest: 8 status_code=1
D [26/Feb/2008:13:47:20 +0100] ReadClient: 8 POST / HTTP/1.1
D [26/Feb/2008:13:47:20 +0100] ProcessIPPRequest: 8 status_code=1
D [26/Feb/2008:13:47:21 +0100] ReadClient: 8 POST / HTTP/1.1
D [26/Feb/2008:13:47:21 +0100] ProcessIPPRequest: 8 status_code=0
D [26/Feb/2008:13:47:21 +0100] CloseClient: 8
D [26/Feb/2008:13:47:21 +0100] AcceptClient: 8 from localhost:631.
D [26/Feb/2008:13:47:21 +0100] ReadClient: 8 POST /printers/HP1600_GORE
HTTP/1.1
D [26/Feb/2008:13:47:21 +0100] print_job: auto-typing file...
D [26/Feb/2008:13:47:21 +0100] print_job: request file type is
application/postscript.
D [26/Feb/2008:13:47:21 +0100] CancelJob: id = 29223
D [26/Feb/2008:13:47:21 +0100] check_quotas: requesting-user-name =
'nab'
D [26/Feb/2008:13:47:21 +0100] print_job: requesting-user-name = 'nab'
I [26/Feb/2008:13:47:21 +0100] Adding start banner page "none" to job
29722.
I [26/Feb/2008:13:47:21 +0100] Adding end banner page "none" to job
29722.
I [26/Feb/2008:13:47:21 +0100] Job 29722 queued on 'HP1600_GORE' by
'nab'.
D [26/Feb/2008:13:47:21 +0100] Job 29722 hold_until = 0
D [26/Feb/2008:13:47:21 +0100] StartJob(29722, 0xf7013b38)
D [26/Feb/2008:13:47:21 +0100] StartJob() id = 29722, file = 0/1
D [26/Feb/2008:13:47:21 +0100] job-sheets=none,none
D [26/Feb/2008:13:47:21 +0100] banner_page = 0
D [26/Feb/2008:13:47:21 +0100] StartJob: argv =
"HP1600_GORE","29722","nab","T953A19433.esc.pcl6","1","page-bottom=86
cpi=12 page-right=57 page-left=57 page-top=72 scaling=100 lpi=7
wrap","/var/spool/cups/d29722-001"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [26/Feb/2008:13:47:21 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [26/Feb/2008:13:47:21 +0100] StartJob: envp[2]="USER=root"
D [26/Feb/2008:13:47:21 +0100] StartJob: envp[3]="CHARSET=iso-8859-15"
D [26/Feb/2008:13:47:21 +0100] StartJob: envp[4]="LANG=en_US"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[5]="PPD=/etc/cups/ppd/HP1600_GORE.ppd"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[6]="CUPS_SERVERROOT=/etc/cups"
D [26/Feb/2008:13:47:21 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[8]="TMPDIR=/var/spool/cups/tmp"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[9]="CONTENT_TYPE=application/postscript"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[10]="DEVICE_URI=smb://zeljkaxp/HP1600_GORE"
D [26/Feb/2008:13:47:21 +0100] StartJob: envp[11]="PRINTER=HP1600_GORE"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[12]="CUPS_DATADIR=/usr/share/cups"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [26/Feb/2008:13:47:21 +0100] StartJob:
envp[14]="CUPS_SERVER=localhost"
D [26/Feb/2008:13:47:21 +0100] StartJob: envp[15]="IPP_PORT=631"
D [26/Feb/2008:13:47:21 +0100] StartJob: statusfds = [ 9 10 ]
D [26/Feb/2008:13:47:21 +0100] StartJob: filterfds[1] = [ 11 -1 ]
D [26/Feb/2008:13:47:21 +0100] StartJob: filter =
"/usr/lib/cups/filter/pstops"
D [26/Feb/2008:13:47:21 +0100] StartJob: filterfds[0] = [ 12 13 ]
D [26/Feb/2008:13:47:21 +0100]
start_process("/usr/lib/cups/filter/pstops", 0xfefeeb20, 0xfefede90, 11,
13, 10)
I [26/Feb/2008:13:47:21 +0100] Started
filter /usr/lib/cups/filter/pstops (PID 21667) for job 29722.
D [26/Feb/2008:13:47:21 +0100] StartJob: filter =
"/usr/lib/cups/filter/foomatic-rip"
D [26/Feb/2008:13:47:21 +0100] StartJob: filterfds[1] = [ 11 14 ]
D [26/Feb/2008:13:47:21 +0100]
start_process("/usr/lib/cups/filter/foomatic-rip", 0xfefeeb20,
0xfefede90, 12, 14, 10)
I [26/Feb/2008:13:47:21 +0100] Started
filter /usr/lib/cups/filter/foomatic-rip (PID 21668) for job 29722.
D [26/Feb/2008:13:47:21 +0100] StartJob: backend =
"/usr/lib/cups/backend/smb"
D [26/Feb/2008:13:47:21 +0100] StartJob: filterfds[0] = [ -1 12 ]
D [26/Feb/2008:13:47:21 +0100]
start_process("/usr/lib/cups/backend/smb", 0xfefeeb20, 0xfefede90, 11,
12, 10)
I [26/Feb/2008:13:47:21 +0100] Started backend /usr/lib/cups/backend/smb
(PID 21669) for job 29722.
D [26/Feb/2008:13:47:21 +0100] ProcessIPPRequest: 8 status_code=0
D [26/Feb/2008:13:47:21 +0100] CloseClient: 8
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Page = 595x842; 12,12 to
583,830
D [26/Feb/2008:13:47:21 +0100] [Job 29722] slowcollate=0, slowduplex=0,
sloworder=0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%Pages: (atend)
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%BoundingBox: 23 15 564
818
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%HiResBoundingBox:
23.400000 15.200000 563.700000 817.100000
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%Creator: AFPL Ghostscript
CVS PRE-RELEASE 813 (pswrite)
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%CreationDate: 2008/02/26
13:47:12
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%DocumentData: Clean7Bit
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%LanguageLevel: 2
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%EndComments
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%BeginProlog
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%BeginResource: procset
GS_pswrite_2_0_1001
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%EndResource
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%EndProlog
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%Page: 1 1
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%Page: 1 1
D [26/Feb/2008:13:47:21 +0100] [Job 29722] pw = 481.0, pl = 684.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageLeft = 57.0, PageRight =
538.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageTop = 770.0, PageBottom =
86.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageWidth = 595.0, PageLength
= 842.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%BeginPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%EndPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] foomatic-rip version
$Revision: 3.43.2.6 $ running...
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Parsing PPD file ...
D [26/Feb/2008:13:47:21 +0100] [Job 29722] *cupsFilter:
"application/vnd.cups-postscript 0 foomatic-rip"
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option ColorSpace
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option PageSize
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option PageRegion
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option ImageableArea
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option PaperDimension
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option InputSlot
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option MediaType
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option Duplex
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option Quality
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option ColorMode
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option BitsPerPlane
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option Copies
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option ICM
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option Nup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option NupOrient
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Added option Font
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Parameter Summary
D [26/Feb/2008:13:47:21 +0100] [Job 29722] -----------------
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Spooler: cups
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Printer: HP1600_GORE
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PPD
file: /etc/cups/ppd/HP1600_GORE.ppd
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Printer model: HP Color
LaserJet 1600 Foomatic/foo2hp (recommended)
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Job title:
T953A19433.esc.pcl6
D [26/Feb/2008:13:47:21 +0100] [Job 29722] File(s) to be printed:
D [26/Feb/2008:13:47:21 +0100] [Job 29722] <STDIN>
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option
'page-bottom=86'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown option
page-bottom=86.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option 'cpi=12'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown option cpi=12.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option
'page-right=57'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown option page-right=57.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option
'page-left=57'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown option page-left=57.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option
'page-top=72'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown option page-top=72.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option
'scaling=100'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown option scaling=100.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option 'lpi=7'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown option lpi=7.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Pondering option 'wrap'
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Unknown boolean option
"wrap".
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
================================================
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] File: <STDIN>
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
================================================
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Reading PostScript input ...
D [26/Feb/2008:13:47:21 +0100] [Job 29722] --> This document is
DSC-conforming!
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] -----------
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginProlog
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%EndProlog
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] -----------
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Inserting PostScript code for
CUPS' page accounting
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*Quality normal
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Quality=normal -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: Quality=normal
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Quality=normal -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*BitsPerPlane 1-BPP
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: BitsPerPlane=1-BPP
--> Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: BitsPerPlane=1-BPP
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: BitsPerPlane=1-BPP
--> Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*ColorMode Monochrome
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: ColorMode=Monochrome
--> Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: ColorMode=Monochrome
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: ColorMode=Monochrome
--> Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*PageRegion A4
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: PageRegion=A4 -->
Option will be set by PostScript interpreter
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: PageSize=A4
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: PageSize=A4 -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*InputSlot Auto
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: InputSlot=Auto -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: InputSlot=Auto
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: InputSlot=Auto -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*MediaType Plain
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: MediaType=Plain -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: MediaType=Plain
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: MediaType=Plain -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*NupOrient port
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: NupOrient=port -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: NupOrient=port
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: NupOrient=port -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature: *Nup
1up
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Nup=1up --> Setting
option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: Nup=1up
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Nup=1up --> Setting
option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*Duplex None
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Duplex=None -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: Duplex=None
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Duplex=None -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature:
*Copies 1
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Copies=1 --> Setting
option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: Copies=1
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: Copies=1 --> Setting
option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginFeature: *ICM
default
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: ICM=default -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%
FoomaticRIPOptionSetting: ICM=default
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Option: ICM=default -->
Setting option
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%EndSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] -----------
D [26/Feb/2008:13:47:21 +0100] [Job 29722] New page: 1 1
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Inserting option code into
"PageSetup" section.
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%EndPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] End of page header
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Stopping search for page
header options
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found:
D [26/Feb/2008:13:47:21 +0100] [Job 29722] p\t0jp\3G0Y1CJuD/`mk45TK
$L-WZ8Ku&B&,NJh(P$luCr_#S-s8Tk~>
D [26/Feb/2008:13:47:21 +0100] [Job 29722] --> Output goes directly to
the renderer now.
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Starting renderer
D [26/Feb/2008:13:47:21 +0100] [Job 29722] JCL: <job data>
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] renderer PID kid4=21671
D [26/Feb/2008:13:47:21 +0100] [Job 29722] renderer command:
foo2hp2600-wrapper -b1 -p9 -s7 -m1 -d1 -n1 -Gdefault
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%PageTrailer
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%Page: 2 2
D [26/Feb/2008:13:47:21 +0100] [Job 29722] pw = 481.0, pl = 684.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageLeft = 57.0, PageRight =
538.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageTop = 770.0, PageBottom =
86.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageWidth = 595.0, PageLength
= 842.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%BeginPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%EndPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%PageTrailer
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%Page: 3 3
D [26/Feb/2008:13:47:21 +0100] [Job 29722] pw = 481.0, pl = 684.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageLeft = 57.0, PageRight =
538.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageTop = 770.0, PageBottom =
86.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] PageWidth = 595.0, PageLength
= 842.0
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%BeginPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] 0 %%EndPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] -----------
D [26/Feb/2008:13:47:21 +0100] [Job 29722] New page: 2 2
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Inserting option code into
"PageSetup" section.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found:
D [26/Feb/2008:13:47:21 +0100] [Job 29722] %%Page: 2 2
D [26/Feb/2008:13:47:21 +0100] [Job 29722] --> Output goes to the FIFO
buffer now.
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%BeginPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found: %%EndPageSetup
D [26/Feb/2008:13:47:21 +0100] [Job 29722] End of page header
D [26/Feb/2008:13:47:21 +0100] [Job 29722] New page found but previous
not printed, print it now.
D [26/Feb/2008:13:47:21 +0100] [Job 29722] Found:
D [26/Feb/2008:13:47:21 +0100] [Job 29722] %%Page: 3 3
D [26/Feb/2008:13:47:21 +0100] [Job 29722] --> Output goes directly to
the renderer now.
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722]
D [26/Feb/2008:13:47:21 +0100] [Job 29722] -----------
....
....
.... and so on...
.... and at the end...
D [26/Feb/2008:13:54:31 +0100] [Job 29722] -----------
D [26/Feb/2008:13:54:31 +0100] [Job 29722] New page: 322 322
D [26/Feb/2008:13:54:31 +0100] [Job 29722] Inserting option code into
"PageSetup" section.
D [26/Feb/2008:13:54:31 +0100] [Job 29722] Found:
D [26/Feb/2008:13:54:31 +0100] [Job 29722] %%Page: 322 322
D [26/Feb/2008:13:54:31 +0100] [Job 29722] --> Output goes to the FIFO
buffer now.
D [26/Feb/2008:13:54:31 +0100] [Job 29722]
D [26/Feb/2008:13:54:31 +0100] [Job 29722]
D [26/Feb/2008:13:54:31 +0100] [Job 29722] Found: %%BeginPageSetup
D [26/Feb/2008:13:54:31 +0100] [Job 29722] Found: %%EndPageSetup
D [26/Feb/2008:13:54:31 +0100] [Job 29722] End of page header
D [26/Feb/2008:13:54:31 +0100] [Job 29722] Stopping search for page
header options
D [26/Feb/2008:13:54:31 +0100] [Job 29722] Found:
D [26/Feb/2008:13:54:31 +0100] [Job 29722] 2195 7485 58 75 /3G
D [26/Feb/2008:13:54:31 +0100] [Job 29722] --> Output goes directly to
the renderer now.
D [26/Feb/2008:13:54:31 +0100] [Job 29722]
D [26/Feb/2008:13:54:32 +0100] [Job 29722] 0 %%PageTrailer
D [26/Feb/2008:13:54:32 +0100] [Job 29722] 0 %%Trailer
D [26/Feb/2008:13:54:32 +0100] [Job 29722] Saw Trailer!
D [26/Feb/2008:13:54:32 +0100] [Job 29722] Saw EOF!
D [26/Feb/2008:13:54:32 +0100] [Job 29722]
D [26/Feb/2008:13:54:32 +0100] [Job 29722] Closing renderer
D [26/Feb/2008:13:54:34 +0100] [Job 29722] tail process done writing
data to STDOUT
D [26/Feb/2008:13:54:34 +0100] [Job 29722] KID4 finished
D [26/Feb/2008:13:54:34 +0100] [Job 29722] KID3 exited with status 0
D [26/Feb/2008:13:54:34 +0100] [Job 29722] KID4 exited with status 0
D [26/Feb/2008:13:54:34 +0100] [Job 29722] Renderer exit stat: 0
D [26/Feb/2008:13:54:34 +0100] [Job 29722] KID3 finished
D [26/Feb/2008:13:54:34 +0100] [Job 29722] Renderer process finished
D [26/Feb/2008:13:54:34 +0100] [Job 29722]
D [26/Feb/2008:13:54:34 +0100] [Job 29722] Closing foomatic-rip.
D [26/Feb/2008:13:54:34 +0100] UpdateJob: job 29722, file 0 is complete.
D [26/Feb/2008:13:54:34 +0100] CancelJob: id = 29722
D [26/Feb/2008:13:54:34 +0100] StopJob: id = 29722, force = 0
D [26/Feb/2008:13:54:34 +0100] StopJob: printer state is 3
