[cups.general] page_log

Mon May 9 06:16:03 PDT 2005

Hello,

I installed cups-1.1.23 from source on RHEL 3.1 and the printing tools provided by XEROX for a XEROX Phaser 6100DN.
Printing a testpage works, but I find no entry in page_log.
As I learned from the documentation, the pstops -filter is responsible for logging pages. So I checked if pstops is called by the printing process (LogLevel debug) . Obviosly pstops is called. 
Can somebody help me??

Rudolf Ladinig
Innsbruck, Austria

Here is the logfile(first starting cups, then printing my job):

I [09/May/2005:11:32:44 +0200] Listening to 0:631
D [09/May/2005:11:32:44 +0200] AddLocation: added location '/'
D [09/May/2005:11:32:44 +0200] DenyIP: / deny 00000000/00000000
D [09/May/2005:11:32:44 +0200] AllowIP: / allow 7f000001/ffffffff
D [09/May/2005:11:32:44 +0200] AddLocation: added location '/admin'
D [09/May/2005:11:32:44 +0200] DenyIP: /admin deny 00000000/00000000
D [09/May/2005:11:32:44 +0200] AllowIP: /admin allow 7f000001/ffffffff
I [09/May/2005:11:32:44 +0200] Loaded configuration file "/etc/cups/cupsd..conf"
I [09/May/2005:11:32:44 +0200] Configured for up to 100 clients.
I [09/May/2005:11:32:44 +0200] Allowing up to 100 client connections per host.
I [09/May/2005:11:32:44 +0200] Full reload is required.
D [09/May/2005:11:32:44 +0200] LoadAllPrinters: Loading printer lp...
D [09/May/2005:11:32:44 +0200] LoadAllPrinters: Loading printer lp1...
D [09/May/2005:11:32:44 +0200] LoadDevices: Added device "ipp"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "lpd"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "parallel:/dev/lp0"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "scsi"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "serial:/dev/ttyS0?baud=115200"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "serial:/dev/ttyS1?baud=115200"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "serial:/dev/ttyS2?baud=115200"...
....
....
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "socket"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "usb://Xerox/Phaser%206100"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "usb:/dev/usb/lp1"...
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "usb:/dev/usb/lp2"...
.....
......
D [09/May/2005:11:32:45 +0200] LoadDevices: Added device "http"...
I [09/May/2005:11:32:45 +0200] LoadPPDs: Read "/etc/cups/ppds.dat", 13 PPDs...
I [09/May/2005:11:32:45 +0200] LoadPPDs: No new or changed PPDs...
D [09/May/2005:11:32:45 +0200] LoadAllJobs: Scanning /var/spool/cups...
D [09/May/2005:11:32:45 +0200] LoadAllJobs: Loading attributes for job 8....
D [09/May/2005:11:32:45 +0200] LoadAllJobs: Loading attributes for job 9....
D [09/May/2005:11:32:45 +0200] LoadAllJobs: Loading attributes for job 10....
I [09/May/2005:11:32:45 +0200] Full reload complete.
D [09/May/2005:11:32:45 +0200] StartListening: NumListeners=1
D [09/May/2005:11:32:45 +0200] StartListening: address=00000000 port=631
D [09/May/2005:11:32:45 +0200] ResumeListening: setting input bits...
I [09/May/2005:11:32:47 +0200] Added remote printer "INF-2-BROTHER"...
D [09/May/2005:11:32:48 +0200] AcceptClient: 5 from localhost:631.
D [09/May/2005:11:32:48 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:32:48 +0200] ProcessIPPRequest: 5 status_code=1
I [09/May/2005:11:32:49 +0200] Added remote class "INF-2-Drucker"...
..
..
D [09/May/2005:11:38:59 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:38:59 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:02 +0200] AcceptClient: 7 from localhost:631.
D [09/May/2005:11:39:02 +0200] ReadClient: 7 POST / HTTP/1.1
D [09/May/2005:11:39:02 +0200] ProcessIPPRequest: 7 status_code=1
D [09/May/2005:11:39:02 +0200] ReadClient: 7 POST / HTTP/1.1
D [09/May/2005:11:39:02 +0200] ProcessIPPRequest: 7 status_code=1
D [09/May/2005:11:39:02 +0200] ReadClient: 7 POST / HTTP/1.1
D [09/May/2005:11:39:02 +0200] ProcessIPPRequest: 7 status_code=0
D [09/May/2005:11:39:02 +0200] CloseClient: 7
D [09/May/2005:11:39:02 +0200] AcceptClient: 7 from localhost:631.
D [09/May/2005:11:39:02 +0200] ReadClient: 7 POST /printers/lp1 HTTP/1.1
D [09/May/2005:11:39:02 +0200] print_job: auto-typing file...
D [09/May/2005:11:39:02 +0200] print_job: request file type is application/postscript.
D [09/May/2005:11:39:02 +0200] check_quotas: requesting-user-name = 'root'
D [09/May/2005:11:39:02 +0200] print_job: requesting-user-name = 'root'
I [09/May/2005:11:39:02 +0200] Adding start banner page "none" to job 11.
I [09/May/2005:11:39:02 +0200] Adding end banner page "none" to job 11.
I [09/May/2005:11:39:02 +0200] Job 11 queued on 'lp1' by 'root'.
D [09/May/2005:11:39:02 +0200] Job 11 hold_until = 0
D [09/May/2005:11:39:02 +0200] StartJob(11, 0x8e60fd0)
D [09/May/2005:11:39:02 +0200] StartJob() id = 11, file = 0/1
D [09/May/2005:11:39:02 +0200] job-sheets=none,none
D [09/May/2005:11:39:02 +0200] banner_page = 0
D [09/May/2005:11:39:02 +0200] StartJob: argv = "lp1","11","root","Acro000E48dMW","1","","/var/spool/cups/d00011-001"
D [09/May/2005:11:39:02 +0200] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [09/May/2005:11:39:02 +0200] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [09/May/2005:11:39:02 +0200] StartJob: envp[2]="USER=root"
D [09/May/2005:11:39:02 +0200] StartJob: envp[3]="CHARSET=utf-8"
D [09/May/2005:11:39:02 +0200] StartJob: envp[4]="LANG=de"
D [09/May/2005:11:39:02 +0200] StartJob: envp[5]="TZ=Europe/Berlin"
D [09/May/2005:11:39:02 +0200] StartJob: envp[6]="PPD=/etc/cups/ppd/lp1.ppd"
D [09/May/2005:11:39:02 +0200] StartJob: envp[7]="CUPS_SERVERROOT=/etc/cups"
D [09/May/2005:11:39:02 +0200] StartJob: envp[8]="RIP_MAX_CACHE=8m"
D [09/May/2005:11:39:02 +0200] StartJob: envp[9]="TMPDIR=/var/spool/cups/tmp"
D [09/May/2005:11:39:02 +0200] StartJob: envp[10]="CONTENT_TYPE=application/postscript"
D [09/May/2005:11:39:02 +0200] StartJob: envp[11]="DEVICE_URI=usb:/dev/usb/lp0"
D [09/May/2005:11:39:02 +0200] StartJob: envp[12]="PRINTER=lp1"
D [09/May/2005:11:39:02 +0200] StartJob: envp[13]="CUPS_DATADIR=/usr/share/cups"
D [09/May/2005:11:39:02 +0200] StartJob: envp[14]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/May/2005:11:39:02 +0200] StartJob: envp[15]="CUPS_SERVER=localhost"
D [09/May/2005:11:39:02 +0200] StartJob: envp[16]="IPP_PORT=631"
D [09/May/2005:11:39:02 +0200] StartJob: statusfds = [ 8 9 ]
D [09/May/2005:11:39:02 +0200] StartJob: filterfds[1] = [ 10 -1 ]
D [09/May/2005:11:39:02 +0200] StartJob: filter = "/usr/lib/cups/filter/pstops"
D [09/May/2005:11:39:02 +0200] StartJob: filterfds[0] = [ 11 12 ]
D [09/May/2005:11:39:02 +0200] start_process("/usr/lib/cups/filter/pstops", 0xbffeca50, 0xbffebdc0, 10, 12, 9)
I [09/May/2005:11:39:02 +0200] Started filter /usr/lib/cups/filter/pstops (PID 1748) for job 11.
D [09/May/2005:11:39:02 +0200] StartJob: filter = "/usr/lib/cups/filter/ppmtosplc"
D [09/May/2005:11:39:02 +0200] StartJob: filterfds[1] = [ 10 13 ]
D [09/May/2005:11:39:02 +0200] start_process("/usr/lib/cups/filter/ppmtosplc", 0xbffeca50, 0xbffebdc0, 11, 13, 9)
I [09/May/2005:11:39:02 +0200] Started filter /usr/lib/cups/filter/ppmtosplc (PID 1750) for job 11.
D [09/May/2005:11:39:02 +0200] StartJob: backend = "/usr/lib/cups/backend/usb"
D [09/May/2005:11:39:02 +0200] StartJob: filterfds[0] = [ -1 11 ]
D [09/May/2005:11:39:02 +0200] start_process("/usr/lib/cups/backend/usb", 0xbffeca50, 0xbffebdc0, 10, 11, 9)
I [09/May/2005:11:39:02 +0200] Started backend /usr/lib/cups/backend/usb (PID 1751) for job 11.
D [09/May/2005:11:39:02 +0200] ProcessIPPRequest: 7 status_code=0
D [09/May/2005:11:39:02 +0200] CloseClient: 7
D [09/May/2005:11:39:02 +0200] [Job 11] Page = 595x842; 12,12 to 582,830
D [09/May/2005:11:39:02 +0200] [Job 11] slowcollate=0, slowduplex=0, sloworder=0
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%Title: (exam-modul1.pdf)
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%Version: 1 3
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%CreationDate: 10:39:02 09.05.2005
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%DocumentData: Clean7Bit
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%LanguageLevel: 2
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%BoundingBox: 0 0 595 842
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%HiResBoundingBox: 0.0 0.0 595..0 842.0
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%Pages: 1
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%DocumentProcessColors: (atend)
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%DocumentSuppliedResources:
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%+ procset (Adobe Acrobat - PDF operators) 1.2 0
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%+ procset (Adobe Acrobat - type operators) 1.2 0
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%EndComments
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%BeginDefaults
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%EndDefaults
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%BeginProlog
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%EndProlog
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%BeginSetup
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%BeginResource: procset l2check 6.0 1
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%Copyright: Copyright 1993,2001 Adobe Systems Incorporated. All Rights Reserved.
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:02 +0200] [Job 11] 0 %%BeginResource: file Pscript_CFF PSVER
D [09/May/2005:11:39:03 +0200] [Job 11] LPGETSTATUS returned a port status of 18...
D [09/May/2005:11:39:03 +0200] AcceptClient: 7 from localhost:631.
D [09/May/2005:11:39:03 +0200] ReadClient: 7 POST / HTTP/1.1
D [09/May/2005:11:39:03 +0200] ProcessIPPRequest: 7 status_code=1
D [09/May/2005:11:39:03 +0200] CloseClient: 7
D [09/May/2005:11:39:03 +0200] AcceptClient: 7 from localhost:631.
D [09/May/2005:11:39:03 +0200] ReadClient: 7 POST / HTTP/1.1
D [09/May/2005:11:39:03 +0200] ProcessIPPRequest: 7 status_code=1
D [09/May/2005:11:39:03 +0200] CloseClient: 7
D [09/May/2005:11:39:03 +0200] AcceptClient: 7 from localhost:631.
D [09/May/2005:11:39:03 +0200] ReadClient: 7 POST / HTTP/1.1
D [09/May/2005:11:39:03 +0200] ProcessIPPRequest: 7 status_code=1
D [09/May/2005:11:39:03 +0200] CloseClient: 7
D [09/May/2005:11:39:03 +0200] AcceptClient: 7 from localhost:631.
D [09/May/2005:11:39:03 +0200] ReadClient: 7 POST / HTTP/1.1
D [09/May/2005:11:39:03 +0200] ProcessIPPRequest: 7 status_code=1
D [09/May/2005:11:39:03 +0200] CloseClient: 7
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%BeginResource: procset pdfvars 6.0 1
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%Copyright: Copyright 1987-2002 Adobe Systems Incorporated. All Rights Reserved.
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%Title: definition of dictionary of variables used by PDF & PDFText procsets
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%BeginResource: procset pdfutil 6.0 1
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%Copyright: Copyright 1993-2001 Adobe Systems Incorporated. All Rights Reserved.
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%Title: Basic utilities used by other PDF procsets
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%BeginResource: procset pdf 6.0 1
D [09/May/2005:11:39:03 +0200] [Job 11] 0 %%Copyright: Copyright 1998-2003 Adobe Systems Incorporated. All Rights Reserved.
D [09/May/2005:11:39:04 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:39:04 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:06 +0200] [Job 11] pscms: Creator value = -3
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Title: General operators for PDF, common to all Language Levels.
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%BeginResource: procset pdflev2 6.0 1
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Copyright: Copyright 1987-2001,2003 Adobe Systems Incorporated. All Rights Reserved.
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Title: PDF operators, with code specific for Level 2
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%BeginResource: procset pdftext 6.0 1
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Copyright: Copyright 1987-2001,2003 Adobe Systems Incorporated. All Rights Reserved.
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Title: Text operators for PDF
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%BeginResource: procset pdfasc..prc 6.0 1
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Copyright: Copyright 1992-2003 Adobe Systems Incorporated. All Rights Reserved.
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%EndSetup
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Page: 1 1
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Page: 1 1
D [09/May/2005:11:39:06 +0200] [Job 11] pw = 570.0, pl = 817.0
D [09/May/2005:11:39:06 +0200] [Job 11] PageLeft = 12.5, PageRight = 582.5
D [09/May/2005:11:39:06 +0200] [Job 11] PageTop = 829.5, PageBottom = 12.5
D [09/May/2005:11:39:06 +0200] [Job 11] PageWidth = 595.0, PageLength = 842.0
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%PageBoundingBox: 0 0 595 842
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%PageHiResBoundingBox: 0.0 0.0 595.0 842.0
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%PageCropBox: 0.0 0.0 595.0 842.0
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%BeginPageSetup
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%BeginResource: font OUOBAA+Helvetica-Bold
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Copyright: Copyright 2005 Adobe System Incorporated. All rights reserved.
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%BeginResource: font ORHBAA+Times-Bold
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Copyright: Copyright 2005 Adobe System Incorporated. All rights reserved.
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%BeginResource: font VULAAA+Times-Roman
D [09/May/2005:11:39:06 +0200] [Job 11] 0 %%Copyright: Copyright 2005 Adobe System Incorporated. All rights reserved.
D [09/May/2005:11:39:07 +0200] [Job 11] 0 %%EndResource
D [09/May/2005:11:39:07 +0200] [Job 11] 0 %%EndPageSetup
D [09/May/2005:11:39:09 +0200] [Job 11] 0 %%PageTrailer
D [09/May/2005:11:39:09 +0200] [Job 11] 0 %%Trailer
D [09/May/2005:11:39:09 +0200] [Job 11] Saw Trailer!
D [09/May/2005:11:39:09 +0200] [Job 11] Saw EOF!
D [09/May/2005:11:39:09 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:39:09 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:14 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:39:14 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:19 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:39:19 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:24 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:39:24 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:29 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:39:29 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:34 +0200] ReadClient: 5 POST / HTTP/1.1
D [09/May/2005:11:39:34 +0200] ProcessIPPRequest: 5 status_code=1
D [09/May/2005:11:39:34 +0200] UpdateJob: job 11, file 0 is complete.
D [09/May/2005:11:39:34 +0200] CancelJob: id = 11
D [09/May/2005:11:39:34 +0200] StopJob: id = 11, force = 0
D [09/May/2005:11:39:34 +0200] StopJob: printer state is 3
..
..
..

-------------------------------------------
Versendet durch aonWebmail (webmail.aon.at)