HPLIP

no page logging for a HP Color Laserjet CP4525

Asked by Karl Roessmann

I have
SUSE Linux Enterprise Server 11 (x86_64) VERSION = 11 PATCHLEVEL = 3
cups-1.5.4-147.1
hplip-3.14.4-97.1

For all printers - including HP Laserjet 600 M602 - page logging works fine,
but for HP Color Laserjet CP4525 I do not get entries in the page_log file.

This can be approved by cups debugging, for the Laserjet 600 I see:

D [21/May/2014:14:41:17 +0200] [Job 7] PAGE: 1 1
D [21/May/2014:15:09:05 +0200] [Job 13] PAGE: 1 1
D [21/May/2014:15:09:06 +0200] [Job 13] PAGE: 2 1
D [21/May/2014:15:09:06 +0200] [Job 13] PAGE: 3 1
D [21/May/2014:15:09:06 +0200] [Job 13] PAGE: 4 1

for CP4525 I do not get this PAGE lines in the error_log and no
lines in the page_log

Some more information about the ppd file:
*% =================================
*% Product/PPD Version Information
*% =================================
*% PPD File Version Information
*FormatVersion: "4.3"
*FileVersion: "1.1"
*HPBuildNumber: "001"
*LanguageVersion: English
*cupsLanguages: "da de es fi fr it ja ko nl nb pt ru sv zh_CN zh_TW"
*cupsFilter: "application/vnd.cups-postscript 0 hpps"
*LanguageEncoding: ISOLatin1
*PCFileName: "HPCP4X2X.PPD"
*HPPDEController ColorOptionsBasic: "ColorOptionsLaserJetsBasic"
*HPPDEController ImageQuality: "ImageQualityLaserJets

Here comes the complete debug of a job:

I [21/May/2014:14:41:27 +0200] [Job 8] Queued on "6a8_a4c_n" by "roess".
I [21/May/2014:14:41:27 +0200] [Job 8] File of type application/pdf queued by "roess".
I [21/May/2014:14:41:27 +0200] [Job 8] Adding end banner page "none".
D [21/May/2014:14:41:27 +0200] [Job 8] job-sheets=none,none
D [21/May/2014:14:41:27 +0200] [Job 8] argv[0]="6a8_a4c_n"
D [21/May/2014:14:41:27 +0200] [Job 8] argv[1]="8"
D [21/May/2014:14:41:27 +0200] [Job 8] argv[2]="roess"
D [21/May/2014:14:41:27 +0200] [Job 8] argv[3]="Printers - CUPS 1.5.4"
D [21/May/2014:14:41:27 +0200] [Job 8] argv[4]="1"
D [21/May/2014:14:41:27 +0200] [Job 8] argv[5]="ColorModel=CMYK Duplex=DuplexNoTumble HPCMYKInks=DefaultCMYK_Plus HPEdgeControl=Normal HPGraphicsHalftone=Detail H
PGraphicsNeutralGrays=Black HPGraphicsRGB=sRGB HPPhotoHalftone=Detail HPPhotoNeutralGrays=ProcessBlack HPPhotoRGB=sRGB noHPRotate180 HPServicesWeb=SupportAndTroub
leshooting HPTextHalftone=Detail HPTextNeutralGrays=Black HPTextRGB=sRGB InputSlot=Auto job-originating-host-name=134.105.215.18 job-uuid=urn:uuid:02722eac-d890-3
6aa-6d2d-e619c4a56d09 lease-duration=300 MediaType=Unspecified noMirrorPrint number-up=1 PageSize=A4 Resolution=600dpi time-at-creation=1400676072 time-at-process
ing=1400676087 uuid=urn:uuid:e1a19fcb-58e1-35b0-662b-8bf878af38fd time-at-creation=1400676087"
D [21/May/2014:14:41:27 +0200] [Job 8] argv[6]="/var/spool/cups/d00008-001"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[8]="HOME=/var/spool/cups/tmp"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[10]="<email address hidden>"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[11]="SOFTWARE=CUPS/1.5.4"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[13]="USER=root"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[14]="CUPS_MAX_MESSAGE=2047"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[15]="CUPS_SERVER=localhost"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[17]="IPP_PORT=631"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[18]="CHARSET=utf-8"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[19]="LANG=en_US.UTF-8"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[20]="PPD=/etc/cups/ppd/6a8_a4c_n.ppd"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[21]="RIP_MAX_CACHE=128m"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[22]="CONTENT_TYPE=application/pdf"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[23]="DEVICE_URI=socket://6a8a4c:9100"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[24]="PRINTER_INFO=6a8_a4c"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[25]="PRINTER_LOCATION=6A8"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[26]="PRINTER=6a8_a4c_n"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[27]="PRINTER_STATE_REASONS=none"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[28]="CUPS_FILETYPE=document"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[29]="FINAL_CONTENT_TYPE=printer/6a8_a4c_n"
D [21/May/2014:14:41:27 +0200] [Job 8] envp[30]="AUTH_I****"
I [21/May/2014:14:41:27 +0200] [Job 8] Started filter /usr/lib/cups/filter/pdftops (PID 28965)
I [21/May/2014:14:41:27 +0200] [Job 8] Started filter /usr/lib/cups/filter/hpps (PID 28966)
I [21/May/2014:14:41:27 +0200] [Job 8] Started backend /usr/lib/cups/backend/socket (PID 28967)
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: +connecting-to-device
D [21/May/2014:14:41:27 +0200] [Job 8] Looking up "6a8a4c"...
D [21/May/2014:14:41:27 +0200] [Job 8] Started filter pdftops (PID 28968)
D [21/May/2014:14:41:27 +0200] [Job 8] Started filter pstops (PID 28969)
D [21/May/2014:14:41:27 +0200] [Job 8] ATTR: marker-colors=#000000,#00FFFF,#FF00FF,#FFFF00,none,none,none
D [21/May/2014:14:41:27 +0200] [Job 8] ATTR: marker-names='"Black Cartridge HP CE260A"','"Cyan Cartridge HP CE261A"','"Magenta Cartridge HP CE263A"','"Yellow Cart
ridge HP CE262A"','"Image Transfer Kit HP CE249A"','"Image Fuser Kit HP 110V-CE246A, 220V-CE247A"','"Toner Collection Unit HP CE265A"'
D [21/May/2014:14:41:27 +0200] [Job 8] ATTR: marker-types=tonerCartridge,tonerCartridge,tonerCartridge,tonerCartridge,transferUnit,fuser,cleanerUnit
D [21/May/2014:14:41:27 +0200] [Job 8] ATTR: marker-levels=0,0,0,0,0,-1,-1
D [21/May/2014:14:41:27 +0200] [Job 8] new_supply_state=a0, change_state=ffff
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -developer-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -developer-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -marker-supply-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -marker-supply-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -opc-near-eol-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: +opc-life-over-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -toner-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: +toner-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] new_state=0, change_state=ffff
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -media-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -media-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] ATTR: marker-names='"Black Cartridge HP CE260A"','"Cyan Cartridge HP CE261A"','"Magenta Cartridge HP CE263A"','"Yellow Cart
ridge HP CE262A"','"Image Transfer Kit HP CE249A"','"Image Fuser Kit HP 110V-CE246A, 220V-CE247A"','"Toner Collection Unit HP CE265A"'
D [21/May/2014:14:41:27 +0200] [Job 8] ATTR: marker-types=tonerCartridge,tonerCartridge,tonerCartridge,tonerCartridge,transferUnit,fuser,cleanerUnit
D [21/May/2014:14:41:27 +0200] [Job 8] ATTR: marker-levels=0,0,0,0,0,-1,-1
D [21/May/2014:14:41:27 +0200] [Job 8] new_supply_state=a0, change_state=ffff
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -developer-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -developer-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -marker-supply-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -marker-supply-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -opc-near-eol-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: +opc-life-over-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -toner-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: +toner-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] new_state=0, change_state=ffff
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -media-low-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -media-empty-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -door-open-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -media-jam-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -input-tray-missing-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -output-tray-missing-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -marker-supply-missing-warning
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -output-area-almost-full-report
D [21/May/2014:14:41:27 +0200] [Job 8] STATE: -output-area-full-warning
D [21/May/2014:14:41:27 +0200] [Job 8] backendWaitLoop(snmp_fd=5, addr=0x7fac55805098, side_cb=0x7fac555f8440)
D [21/May/2014:14:41:27 +0200] [Job 8] Page = 595x842; 12,12 to 583,830
D [21/May/2014:14:41:27 +0200] [Job 8] slow_collate=0, slow_duplex=0, slow_order=0
D [21/May/2014:14:41:27 +0200] [Job 8] Before copy_comments - %!PS-Adobe-3.0
D [21/May/2014:14:41:27 +0200] [Job 8] %!PS-Adobe-3.0
D [21/May/2014:14:41:27 +0200] [Job 8] %%Creator: cairo 1.9.5 (http://cairographics.org)
D [21/May/2014:14:41:27 +0200] [Job 8] %%LanguageLevel: 3
D [21/May/2014:14:41:27 +0200] [Job 8] %%DocumentSuppliedResources: (atend)
D [21/May/2014:14:41:27 +0200] [Job 8] %%DocumentMedia: plain 596 842 0 () ()
D [21/May/2014:14:41:27 +0200] [Job 8] %%BoundingBox: 0 0 596 842
D [21/May/2014:14:41:27 +0200] [Job 8] %%Pages: 1
D [21/May/2014:14:41:27 +0200] [Job 8] %%EndComments
D [21/May/2014:14:41:27 +0200] [Job 8] Before copy_prolog - %%BeginDefaults
D [21/May/2014:14:41:27 +0200] [Job 8] Before copy_setup - %%BeginSetup
D [21/May/2014:14:41:28 +0200] [Job 8] Connecting to 6a8a4c:9100
I [21/May/2014:14:41:28 +0200] [Job 8] Connecting to printer.
D [21/May/2014:14:41:28 +0200] [Job 8] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [21/May/2014:14:41:28 +0200] [Job 8] STATE: -connecting-to-device
I [21/May/2014:14:41:28 +0200] [Job 8] Connected to printer.
D [21/May/2014:14:41:28 +0200] [Job 8] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [21/May/2014:14:41:28 +0200] [Job 8] Connected to 134.105.232.162:9100...
D [21/May/2014:14:41:28 +0200] [Job 8] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x7fac55805098, use_bc=1, side_cb=0x7fac555f8440)
D [21/May/2014:14:41:28 +0200] [Job 8] ATTR: marker-levels=93,96,96,96,100,-1,-1
D [21/May/2014:14:41:28 +0200] [Job 8] new_supply_state=0, change_state=a0
D [21/May/2014:14:41:28 +0200] [Job 8] STATE: -opc-life-over-warning
D [21/May/2014:14:41:28 +0200] [Job 8] STATE: -toner-empty-warning
D [21/May/2014:14:41:28 +0200] [Job 8] new_state=0, change_state=0
D [21/May/2014:14:41:29 +0200] [Job 8] Before page loop - %%Page: 1 1
D [21/May/2014:14:41:29 +0200] [Job 8] Copying page 1...
D [21/May/2014:14:41:29 +0200] [Job 8] pagew = 571.1, pagel = 817.6
D [21/May/2014:14:41:29 +0200] [Job 8] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [21/May/2014:14:41:29 +0200] [Job 8] PageLeft = 12.0, PageRight = 583.1
D [21/May/2014:14:41:29 +0200] [Job 8] PageTop = 829.7, PageBottom = 12.1
D [21/May/2014:14:41:29 +0200] [Job 8] PageWidth = 595.0, PageLength = 842.0
D [21/May/2014:14:41:29 +0200] [Job 8] Wrote 1 pages...

          Here I would expect the 'PAGE: 1 1' line, which I get for other printers

D [21/May/2014:14:41:29 +0200] [Job 8] PID 28969 (pstops) exited with no errors.
D [21/May/2014:14:41:29 +0200] [Job 8] PID 28968 (pdftops) exited with no errors.
I [21/May/2014:14:41:29 +0200] [Job 8] Waiting for printer to finish.
D [21/May/2014:14:41:29 +0200] [Job 8] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO
D [21/May/2014:14:41:29 +0200] [Job 8] ATTR: marker-levels=93,96,96,96,100,-1,-1
D [21/May/2014:14:41:29 +0200] [Job 8] new_supply_state=0, change_state=0
D [21/May/2014:14:41:29 +0200] [Job 8] new_state=0, change_state=0
I [21/May/2014:14:41:29 +0200] [Job 8] Ready to print.
D [21/May/2014:14:41:29 +0200] [Job 8] Set job-printer-state-message to "Ready to print.", current level=INFO
I [21/May/2014:14:41:29 +0200] [Job 8] Job completed.
D [21/May/2014:14:42:05 +0200] [Job 8] Unloading...
D [21/May/2014:15:08:15 +0200] [Job 8] Loading from cache...

Could the PPD file be the problem ?

Regards, Karl

Question information

Language:
English Edit question
Status:
Expired
For:
HPLIP Edit question
Assignee:
No assignee Edit question
Last query:
Last reply:
Revision history for this message
Johannes Meixner (jsmeix) said : 		#1

I am not a HPLIP team member - therefore the following
is only a question that is only meant as a hint what might
make a difference between the HP Laserjet 600 M602
and the HP Color Laserjet CP4525.
A HPLIP team member should still have a look.

Karl Roessmann,
could you show us which filters are run for the
HP Laserjet 600 M602 i.e. only the "Started filter"
lines in /var/log/cups/error_log for a single print job
that is sent to the HP Laserjet 600 M602.

I think I vaguely remember that the last filter (before the
backend) is responsible to emit the "PAGE:" messages.

For the HP Color Laserjet CP4525 the last filter
is "/usr/lib/cups/filter/hpps" and that filter does
not emit "PAGE:" messages (at least there is no
"page" in its code).

Perhaps for the HP Laserjet 600 M602 a different
program is run as last filter and that emits
"PAGE:" messages?

Revision history for this message
Karl Roessmann (k-roessmann) said : 		#2

There is a difference, first I simply grep 'filter' and

on the good HP Laserjet 600 M602 I have:

fkfcupsn:/etc/cups/ppd # grep 'Job 7' /var/log/cups/error_log | grep -v 'of print data' | grep filter
D [21/May/2014:14:41:16 +0200] [Job 7] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
I [21/May/2014:14:41:16 +0200] [Job 7] Started filter /usr/lib/cups/filter/pdftops (PID 28961)
D [21/May/2014:14:41:16 +0200] [Job 7] Started filter pdftops (PID 28963)
D [21/May/2014:14:41:16 +0200] [Job 7] Started filter pstops (PID 28964)

on the bad CP4525:

fkfcupsn:/etc/cups/ppd # grep 'Job 8' /var/log/cups/error_log | grep -v 'of print data' | grep filter
D [21/May/2014:14:41:27 +0200] [Job 8] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
I [21/May/2014:14:41:27 +0200] [Job 8] Started filter /usr/lib/cups/filter/pdftops (PID 28965)
I [21/May/2014:14:41:27 +0200] [Job 8] Started filter /usr/lib/cups/filter/hpps (PID 28966)
D [21/May/2014:14:41:27 +0200] [Job 8] Started filter pdftops (PID 28968)
D [21/May/2014:14:41:27 +0200] [Job 8] Started filter pstops (PID 28969)

I have some problem to understand the redundancy between D- and I-messages in the log, but
the main difference is the hpps filter, which I have for the CP4525.

and here is a complete log of the HP Laserjet 600 M602

I [21/May/2014:14:41:16 +0200] [Job 7] Adding start banner page "none".
I [21/May/2014:14:41:16 +0200] [Job 7] Queued on "6a8_a4m_n" by "roess".
I [21/May/2014:14:41:16 +0200] [Job 7] File of type application/pdf queued by "roess".
I [21/May/2014:14:41:16 +0200] [Job 7] Adding end banner page "none".
D [21/May/2014:14:41:16 +0200] [Job 7] job-sheets=none,none
D [21/May/2014:14:41:16 +0200] [Job 7] argv[0]="6a8_a4m_n"
D [21/May/2014:14:41:16 +0200] [Job 7] argv[1]="7"
D [21/May/2014:14:41:16 +0200] [Job 7] argv[2]="roess"
D [21/May/2014:14:41:16 +0200] [Job 7] argv[3]="Printers - CUPS 1.5.4"
D [21/May/2014:14:41:16 +0200] [Job 7] argv[4]="1"
D [21/May/2014:14:41:16 +0200] [Job 7] argv[5]="Duplex=DuplexNoTumble noHPEconoMode noHPEdgeToEdge HPPaperSource=AutomaticallySelect HPPrintQuality=FastRes1200 jo
b-originating-host-name=134.105.215.18 job-uuid=urn:uuid:59aad0df-2f42-34ba-7aa9-1f3bb3ea4c8a lease-duration=300 MediaType=Plain number-up=1 OutputBin=None PageSi
ze=A4 time-at-creation=1400676060 time-at-processing=1400676076 uuid=urn:uuid:1e387bb3-7627-3d1a-7e15-925c12f68eee time-at-creation=1400676076"
D [21/May/2014:14:41:16 +0200] [Job 7] argv[6]="/var/spool/cups/d00007-001"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[8]="HOME=/var/spool/cups/tmp"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[10]="<email address hidden>"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[11]="SOFTWARE=CUPS/1.5.4"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[13]="USER=root"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[14]="CUPS_MAX_MESSAGE=2047"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[15]="CUPS_SERVER=localhost"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[17]="IPP_PORT=631"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[18]="CHARSET=utf-8"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[19]="LANG=en_US.UTF-8"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[20]="PPD=/etc/cups/ppd/6a8_a4m_n.ppd"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[21]="RIP_MAX_CACHE=128m"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[22]="CONTENT_TYPE=application/pdf"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[23]="DEVICE_URI=socket://6a8a4m:9100"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[24]="PRINTER_INFO=6a8_a4m"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[25]="PRINTER_LOCATION=6A8"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[26]="PRINTER=6a8_a4m_n"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[27]="PRINTER_STATE_REASONS=none"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[28]="CUPS_FILETYPE=document"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[30]="AUTH_I****"
I [21/May/2014:14:41:16 +0200] [Job 7] Started filter /usr/lib/cups/filter/pdftops (PID 28961)
I [21/May/2014:14:41:16 +0200] [Job 7] Started backend /usr/lib/cups/backend/socket (PID 28962)
D [21/May/2014:14:41:16 +0200] [Job 7] STATE: +connecting-to-device
D [21/May/2014:14:41:16 +0200] [Job 7] Looking up "6a8a4m"...
D [21/May/2014:14:41:16 +0200] [Job 7] Started filter pdftops (PID 28963)
D [21/May/2014:14:41:16 +0200] [Job 7] Started filter pstops (PID 28964)
D [21/May/2014:14:41:16 +0200] [Job 7] backendWaitLoop(snmp_fd=5, addr=0x7f89c60bf098, side_cb=0x7f89c5eb2440)
D [21/May/2014:14:41:16 +0200] [Job 7] Page = 595x842; 12,12 to 583,830
D [21/May/2014:14:41:16 +0200] [Job 7] slow_collate=0, slow_duplex=0, slow_order=0
D [21/May/2014:14:41:16 +0200] [Job 7] Before copy_comments - %!PS-Adobe-3.0
D [21/May/2014:14:41:16 +0200] [Job 7] %!PS-Adobe-3.0
D [21/May/2014:14:41:16 +0200] [Job 7] %%Creator: cairo 1.9.5 (http://cairographics.org)
D [21/May/2014:14:41:16 +0200] [Job 7] %%LanguageLevel: 3
D [21/May/2014:14:41:16 +0200] [Job 7] %%DocumentSuppliedResources: (atend)
D [21/May/2014:14:41:16 +0200] [Job 7] %%DocumentMedia: plain 596 842 0 () ()
D [21/May/2014:14:41:16 +0200] [Job 7] %%BoundingBox: 0 0 596 842
D [21/May/2014:14:41:16 +0200] [Job 7] %%Pages: 1
D [21/May/2014:14:41:16 +0200] [Job 7] %%EndComments
D [21/May/2014:14:41:16 +0200] [Job 7] Before copy_prolog - %%BeginDefaults
D [21/May/2014:14:41:16 +0200] [Job 7] Connecting to 6a8a4m:9100
I [21/May/2014:14:41:16 +0200] [Job 7] Connecting to printer.
D [21/May/2014:14:41:16 +0200] [Job 7] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [21/May/2014:14:41:16 +0200] [Job 7] Before copy_setup - %%BeginSetup
D [21/May/2014:14:41:16 +0200] [Job 7] STATE: -connecting-to-device
I [21/May/2014:14:41:16 +0200] [Job 7] Connected to printer.
D [21/May/2014:14:41:16 +0200] [Job 7] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[10]="<email address hidden>"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[11]="SOFTWARE=CUPS/1.5.4"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[13]="USER=root"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[14]="CUPS_MAX_MESSAGE=2047"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[15]="CUPS_SERVER=localhost"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[17]="IPP_PORT=631"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[18]="CHARSET=utf-8"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[19]="LANG=en_US.UTF-8"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[20]="PPD=/etc/cups/ppd/6a8_a4m_n.ppd"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[21]="RIP_MAX_CACHE=128m"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[22]="CONTENT_TYPE=application/pdf"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[23]="DEVICE_URI=socket://6a8a4m:9100"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[24]="PRINTER_INFO=6a8_a4m"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[25]="PRINTER_LOCATION=6A8"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[26]="PRINTER=6a8_a4m_n"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[27]="PRINTER_STATE_REASONS=none"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[28]="CUPS_FILETYPE=document"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [21/May/2014:14:41:16 +0200] [Job 7] envp[30]="AUTH_I****"
I [21/May/2014:14:41:16 +0200] [Job 7] Started filter /usr/lib/cups/filter/pdftops (PID 28961)
I [21/May/2014:14:41:16 +0200] [Job 7] Started backend /usr/lib/cups/backend/socket (PID 28962)
D [21/May/2014:14:41:16 +0200] [Job 7] STATE: +connecting-to-device
D [21/May/2014:14:41:16 +0200] [Job 7] Looking up "6a8a4m"...
D [21/May/2014:14:41:16 +0200] [Job 7] Started filter pdftops (PID 28963)
D [21/May/2014:14:41:16 +0200] [Job 7] Started filter pstops (PID 28964)
D [21/May/2014:14:41:16 +0200] [Job 7] backendWaitLoop(snmp_fd=5, addr=0x7f89c60bf098, side_cb=0x7f89c5eb2440)
D [21/May/2014:14:41:16 +0200] [Job 7] Page = 595x842; 12,12 to 583,830
D [21/May/2014:14:41:16 +0200] [Job 7] slow_collate=0, slow_duplex=0, slow_order=0
D [21/May/2014:14:41:16 +0200] [Job 7] Before copy_comments - %!PS-Adobe-3.0
D [21/May/2014:14:41:16 +0200] [Job 7] %!PS-Adobe-3.0
D [21/May/2014:14:41:16 +0200] [Job 7] %%Creator: cairo 1.9.5 (http://cairographics.org)
D [21/May/2014:14:41:16 +0200] [Job 7] %%LanguageLevel: 3
D [21/May/2014:14:41:16 +0200] [Job 7] %%DocumentSuppliedResources: (atend)
D [21/May/2014:14:41:16 +0200] [Job 7] %%DocumentMedia: plain 596 842 0 () ()
D [21/May/2014:14:41:16 +0200] [Job 7] %%BoundingBox: 0 0 596 842
D [21/May/2014:14:41:16 +0200] [Job 7] %%Pages: 1
D [21/May/2014:14:41:16 +0200] [Job 7] %%EndComments
D [21/May/2014:14:41:16 +0200] [Job 7] Before copy_prolog - %%BeginDefaults
D [21/May/2014:14:41:16 +0200] [Job 7] Connecting to 6a8a4m:9100
I [21/May/2014:14:41:16 +0200] [Job 7] Connecting to printer.
D [21/May/2014:14:41:16 +0200] [Job 7] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [21/May/2014:14:41:16 +0200] [Job 7] Before copy_setup - %%BeginSetup
D [21/May/2014:14:41:16 +0200] [Job 7] STATE: -connecting-to-device
I [21/May/2014:14:41:16 +0200] [Job 7] Connected to printer.
D [21/May/2014:14:41:16 +0200] [Job 7] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [21/May/2014:14:41:16 +0200] [Job 7] Connected to 134.105.232.161:9100...
D [21/May/2014:14:41:16 +0200] [Job 7] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x7f89c60bf098, use_bc=1, side_cb=0x7f89c5eb2440)
D [21/May/2014:14:41:17 +0200] [Job 7] Before page loop - %%Page: 1 1
D [21/May/2014:14:41:17 +0200] [Job 7] Copying page 1...
D [21/May/2014:14:41:17 +0200] [Job 7] PAGE: 1 1
D [21/May/2014:14:41:17 +0200] [Job 7] pagew = 571.0, pagel = 818.0
D [21/May/2014:14:41:17 +0200] [Job 7] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [21/May/2014:14:41:17 +0200] [Job 7] PageLeft = 12.0, PageRight = 583.0
D [21/May/2014:14:41:17 +0200] [Job 7] PageTop = 830.0, PageBottom = 12.0
D [21/May/2014:14:41:17 +0200] [Job 7] PageWidth = 595.0, PageLength = 842.0
D [21/May/2014:14:41:18 +0200] [Job 7] PID 28963 (pdftops) exited with no errors.
D [21/May/2014:14:41:19 +0200] [Job 7] Wrote 1 pages...
D [21/May/2014:14:41:19 +0200] [Job 7] PID 28964 (pstops) exited with no errors.
I [21/May/2014:14:41:19 +0200] [Job 7] Waiting for printer to finish.
D [21/May/2014:14:41:19 +0200] [Job 7] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO
I [21/May/2014:14:41:19 +0200] [Job 7] Ready to print.
D [21/May/2014:14:41:19 +0200] [Job 7] Set job-printer-state-message to "Ready to print.", current level=INFO
I [21/May/2014:14:41:19 +0200] [Job 7] Job completed.
D [21/May/2014:14:41:20 +0200] [Job 7] Unloading...
D [21/May/2014:14:41:20 +0200] [Job 7] Loading attributes...
D [21/May/2014:14:42:05 +0200] [Job 7] Unloading...
D [21/May/2014:15:08:15 +0200] [Job 7] Loading from cache...

Karl

Revision history for this message
Karl Roessmann (k-roessmann) said : 		#3

The hpps filter is the reason.
if I remove this line from the ppd file, I get the accounting lines in page_log !

*cupsFilter: "application/vnd.cups-postscript 0 hpps"

and I could print out some pages.
but this is probably not a solution.
For what do I need the hpps filter ?

Karl

Revision history for this message
Karl Roessmann (k-roessmann) said : 		#4

so the hpps filter does not provide page_log entries.
What can I do to get some kind accounting ?

Revision history for this message
Launchpad Janitor (janitor) said : 		#5

This question was expired because it remained in the 'Open' state without activity for the last 15 days.