hp-1020 installed, accepts jobs, but does not actually print
by Johncc330 from LinuxQuestions.org on (#6HA0R)
After reading 100's of quite similar threads over a load of forums, I'm about to give up... Here's the situation:
- I have a machine which has been running quite some time (4 or more years) without problems,
Code:Linux sally.xxx.yyy 4.14.67 #1 SMP Fri Aug 24 16:01:52 CDT 2018 x86_64 AMD A6-9500 RADEON R5, 8 COMPUTE CORES 2C+6G AuthenticAMD GNU/LinuxIt has cups 2.2.6 installed with a Brother HL1200 printer connected. Some mechanical issue with the printer made me install a backup HP1020 printer. After unsuccesfully experimenting and encountering the weirdest error messages, I decided to remove cups and hplip, whatever other print related things, and I re-installed cups, cups-filters, foo2zjs (compiled & installed), downloaded the firmware for the HP1020 (and uploaded it to the printer manually, as I could not find anything related in dmesg)...
According to cups, all is well - it accepts jobs, marks them as 'done', etc.
But nothing appears on paper. I checked the following:
# lpstat -a
HP_LaserJet_1020 accepting requests since Wed 20 Dec 2023 08:59:45 PM -03
Code:[43399.769537] usblp0: removed
[43407.817932] usblp 1-3:1.0: usblp0: USB Bidirectional printer dev 4 if 0 alt 0 proto 2 vid 0x03F0 pid 0x2B17
[43490.479166] usblp0: removed
[43498.685250] usblp 1-3:1.0: usblp0: USB Bidirectional printer dev 4 if 0 alt 0 proto 2 vid 0x03F0 pid 0x2B17
[45481.209572] usblp0: removedThis repeats - I think each print command.
The following is the error_log of cups. There are a couple (bolded) things I find suspicious, but I don't see a definite stop...
Code:D [20/Dec/2023:20:59:53 -0300] [Job 7] PID 9307 (pstops) exited with no errors.
D [20/Dec/2023:20:59:53 -0300] [Job 7] PID 9306 (pdftops) exited with no errors.
D [20/Dec/2023:20:59:53 -0300] [Job 7] Waiting for read thread to exit...
D [20/Dec/2023:20:59:53 -0300] [Job 7] Read thread still active, aborting the pending read...
D [20/Dec/2023:20:59:53 -0300] [Job 7] PID 9300 (/usr/lib64/cups/backend/usb) exited with no errors.
D [20/Dec/2023:20:59:53 -0300] [Job 7] End of messages
D [20/Dec/2023:20:59:53 -0300] [Job 7] printer-state=3(idle)
D [20/Dec/2023:20:59:53 -0300] [Job 7] printer-state-message="Filter failed"
D [20/Dec/2023:20:59:53 -0300] [Job 7] printer-state-reasons=none
E [20/Dec/2023:21:07:22 -0300] [Job 8] Job stopped due to filter errors; please consult the error_log file for details.
D [20/Dec/2023:21:07:22 -0300] [Job 8] The following messages were recorded from 21:07:14 to 21:07:22
D [20/Dec/2023:21:07:22 -0300] [Job 8] Applying default options...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Adding start banner page "none".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Queued on "HP_LaserJet_1020" by "root".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Auto-typing file...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Request file type is text/plain.
D [20/Dec/2023:21:07:22 -0300] [Job 8] File of type text/plain queued by "root".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Adding end banner page "none".
D [20/Dec/2023:21:07:22 -0300] [Job 8] time-at-processing=1703117234
D [20/Dec/2023:21:07:22 -0300] [Job 8] 3 filters for job:
D [20/Dec/2023:21:07:22 -0300] [Job 8] texttopdf (text/plain to application/pdf, cost 32)
D [20/Dec/2023:21:07:22 -0300] [Job 8] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [20/Dec/2023:21:07:22 -0300] [Job 8] foomatic-rip (application/vnd.cups-pdf to printer/HP_LaserJet_1020, cost 0)
D [20/Dec/2023:21:07:22 -0300] [Job 8] job-sheets=none,none
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[0]="HP_LaserJet_1020"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[1]="8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[2]="root"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[3]="hosts"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[4]="1"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1703117234 time-at-processing=1703117234 document-name-supplied=hosts"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[6]="/var/spool/cups/d00008-001"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[2]="CUPS_DOCROOT=/usr/share/doc/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[5]="CUPS_SERVERBIN=/usr/lib64/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[8]="HOME=/var/spool/cups/tmp"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[9]="PATH=/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[10]="SERVER_ADMIN=root@sally.sklein.com"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[11]="SOFTWARE=CUPS/2.2.8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[13]="USER=root"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[14]="CUPS_MAX_MESSAGE=2047"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[17]="IPP_PORT=631"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[18]="CHARSET=utf-8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[19]="LANG=en_US.UTF-8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[20]="PPD=/etc/cups/ppd/HP_LaserJet_1020.ppd"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[21]="RIP_MAX_CACHE=128m"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[22]="CONTENT_TYPE=text/plain"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[23]="DEVICE_URI=usb://HP/LaserJet%201020?serial=FZ05MV6"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[24]="PRINTER_INFO=HP LaserJet 1020"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[25]="PRINTER_LOCATION=sally"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[26]="PRINTER=HP_LaserJet_1020"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[27]="PRINTER_STATE_REASONS=none"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[28]="CUPS_FILETYPE=document"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-pdf"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[30]="AUTH_I****"
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter /usr/lib64/cups/filter/texttopdf (PID 12319)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter /usr/lib64/cups/filter/pdftopdf (PID 12320)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter /usr/lib64/cups/filter/foomatic-rip (PID 12321)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started backend /usr/lib64/cups/backend/usb (PID 12322)
D [20/Dec/2023:21:07:22 -0300] [Job 8] pdftopdf: Last filter determined by the PPD: foomatic-rip; FINAL_CONTENT_TYPE: application/vnd.cups-pdf => pdftopdf will log pages in page_log.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Page = 595x842; 11,11 to 584,831
D [20/Dec/2023:21:07:22 -0300] [Job 8] Loading USB quirks from \"/usr/share/cups/usb\".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Loaded 162 quirks.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printing on printer with URI: usb://HP/LaserJet%201020?serial=FZ05MV6
D [20/Dec/2023:21:07:22 -0300] [Job 8] Calling FindDeviceById(cups-HP_LaserJet_1020)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Failed to send: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [20/Dec/2023:21:07:22 -0300] [Job 8] Failed to get find device cups-HP_LaserJet_1020
D [20/Dec/2023:21:07:22 -0300] [Job 8] \'CM Color Calibration\' Mode in SPOOLER-LESS: Off
D [20/Dec/2023:21:07:22 -0300] [Job 8] Getting input from file
D [20/Dec/2023:21:07:22 -0300] [Job 8] foomatic-rip version 1.21.0 running...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Parsing PPD file ...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option ColorSpace
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option PageSize
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Quality
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Resolution
D [20/Dec/2023:21:07:22 -0300] [Job 8] libusb_get_device_list=10
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option ImageableArea
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option PaperDimension
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option InputSlot
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option MediaType
D [20/Dec/2023:21:07:22 -0300] [Job 8] STATE: +connecting-to-device
D [20/Dec/2023:21:07:22 -0300] [Job 8] STATE: -connecting-to-device
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Density
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Copies
D [20/Dec/2023:21:07:22 -0300] [Job 8] PAGE: 1 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12319 (/usr/lib64/cups/filter/texttopdf) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer found with device ID: MFG:Hewlett-Packard;MDL:HP LaserJet 1020;CMD:ACL;CLS:PRINTER;DES:HP LaserJet 1020;FWVER:20050309; Device URI: usb://HP/LaserJet%201020?serial=FZ05MV6
D [20/Dec/2023:21:07:22 -0300] [Job 8] Device protocol: 2
D [20/Dec/2023:21:07:22 -0300] [Job 8] Sending data to printer.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option halftone
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option NupOrient
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option NupPages
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Font
D [20/Dec/2023:21:07:22 -0300] [Job 8] Parameter Summary
D [20/Dec/2023:21:07:22 -0300] [Job 8] -----------------
D [20/Dec/2023:21:07:22 -0300] [Job 8] Spooler: cups
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer: HP_LaserJet_1020
D [20/Dec/2023:21:07:22 -0300] [Job 8] Shell: /bin/bash
D [20/Dec/2023:21:07:22 -0300] [Job 8] PPD file: /etc/cups/ppd/HP_LaserJet_1020.ppd
D [20/Dec/2023:21:07:22 -0300] [Job 8] ATTR file:
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer model: HP LaserJet 1020 Foomatic/foo2zjs-z1 (recommended)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Job title: hosts
D [20/Dec/2023:21:07:22 -0300] [Job 8] File(s) to be printed:
D [20/Dec/2023:21:07:22 -0300] [Job 8] <STDIN>
D [20/Dec/2023:21:07:22 -0300] [Job 8] Ghostscript extra search path (\'GS_LIB\'): /usr/share/cups/fonts
D [20/Dec/2023:21:07:22 -0300] [Job 8] Value \" V\" for option \"Copies\", parameter \"Copies\" is smaller than the minimum value \"1\"
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printing system options:
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'finishings=3\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option finishings=3.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'number-up=1\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option number-up=1.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'job-originating-host-name=localhost\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option job-originating-host-name=localhost.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'date-time-at-creation=\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option date-time-at-creation=.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'date-time-at-processing=\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option date-time-at-processing=.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'time-at-creation=1703117234\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option time-at-creation=1703117234.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'time-at-processing=1703117234\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option time-at-processing=1703117234.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'document-name-supplied=hosts\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option document-name-supplied=hosts.
D [20/Dec/2023:21:07:22 -0300] [Job 8] CM Color Calibration Mode in CUPS: Off
D [20/Dec/2023:21:07:22 -0300] [Job 8] Options from the PPD file:
D [20/Dec/2023:21:07:22 -0300] [Job 8] ================================================
D [20/Dec/2023:21:07:22 -0300] [Job 8] File: <STDIN>
D [20/Dec/2023:21:07:22 -0300] [Job 8] ================================================
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12320 (/usr/lib64/cups/filter/pdftopdf) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Filetype: PDF
D [20/Dec/2023:21:07:22 -0300] [Job 8] Neither PDF renderer command line nor Ghostscript-based renderer command line found
D [20/Dec/2023:21:07:22 -0300] [Job 8] Driver does not understand PDF input, converting to PostScript
D [20/Dec/2023:21:07:22 -0300] [Job 8] Storing temporary files in /var/spool/cups/tmp
D [20/Dec/2023:21:07:22 -0300] [Job 8] Starting process \"pdf-to-ps\" (generation 1)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer make and model: HP HP LaserJet 1020
D [20/Dec/2023:21:07:22 -0300] [Job 8] Switching to Poppler\'s pdftops instead of Ghostscript for old HP LaserJet (\"LaserJet <number>\", no letters before <number>) printers to work around bugs in the printer\'s PS interpreters
D [20/Dec/2023:21:07:22 -0300] [Job 8] Running command line for pstops: pstops 8 root hosts 1 \' finishings=3 job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1703117234 time-at-processing=1703117234 document-name-supplied=hosts\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Using image rendering resolution 600 dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Running command line for pdftops: pdftops -level2 -origpagesizes -nocenter -r 600 /var/spool/cups/tmp/foomatic-dzPx2o -
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter pdftops (PID 12328)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter pstops (PID 12329)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Page = 595x842; 11,11 to 584,831
D [20/Dec/2023:21:07:22 -0300] [Job 8] slow_collate=0, slow_duplex=0, slow_order=0
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before copy_comments - %!PS-Adobe-3.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] %!PS-Adobe-3.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] %Produced by poppler pdftops version: 0.68.0 (http://poppler.freedesktop.org)
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%Creator: texttopdf/1.21.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%LanguageLevel: 2
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%DocumentSuppliedResources: (atend)
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%DocumentMedia: A4 595 842 0 () ()
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%BoundingBox: 0 0 595 842
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%Pages: 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%EndComments
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before copy_prolog - %%BeginProlog
D [20/Dec/2023:21:07:22 -0300] [Job 8] Filetype: PostScript
D [20/Dec/2023:21:07:22 -0300] [Job 8] Reading PostScript input ...
D [20/Dec/2023:21:07:22 -0300] [Job 8] --> This document is DSC-conforming!
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found %RBINumCopies: 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] -----------
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginProlog
D [20/Dec/2023:21:07:22 -0300] [Job 8] Inserting option code into \"Prolog\" section.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before copy_setup - %%BeginSetup
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%EndProlog
D [20/Dec/2023:21:07:22 -0300] [Job 8] -----------
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginSetup
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginFeature: *Quality normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Quality=normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %% FoomaticRIPOptionSetting: Quality=normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Quality=normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginFeature: *halftone default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: halftone=default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %% FoomaticRIPOptionSetting: halftone=default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: halftone=default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginFeature: *Resolution 1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Resolution=1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %% FoomaticRIPOptionSetting: Resolution=1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Resolution=1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] double free or corruption (fasttop)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Sent 0 bytes...
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12321 (/usr/lib64/cups/filter/foomatic-rip) crashed on signal 6.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Hint: Try setting the LogLevel to "debug" to find out more.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before page loop - %%Page: 1 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] Copying page 1...
D [20/Dec/2023:21:07:22 -0300] [Job 8] pagew = 572.3, pagel = 819.3
D [20/Dec/2023:21:07:22 -0300] [Job 8] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [20/Dec/2023:21:07:22 -0300] [Job 8] PageLeft = 11.3, PageRight = 583.7
D [20/Dec/2023:21:07:22 -0300] [Job 8] PageTop = 830.7, PageBottom = 11.3
D [20/Dec/2023:21:07:22 -0300] [Job 8] PageWidth = 595.0, PageLength = 842.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] Wrote 1 pages...
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12329 (pstops) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12328 (pdftops) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Waiting for read thread to exit...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Read thread still active, aborting the pending read...
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12322 (/usr/lib64/cups/backend/usb) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] End of messages
D [20/Dec/2023:21:07:22 -0300] [Job 8] printer-state=3(idle)
D [20/Dec/2023:21:07:22 -0300] [Job 8] printer-state-message="Filter failed"
D [20/Dec/2023:21:07:22 -0300] [Job 8] printer-state-reasons=noneThe CUPS page marks the job with 'Filter failed'. Again, after a lot of tests, I could
not pinpoint any problem, except for the bold ones above.
Help!
John
- I have a machine which has been running quite some time (4 or more years) without problems,
Code:Linux sally.xxx.yyy 4.14.67 #1 SMP Fri Aug 24 16:01:52 CDT 2018 x86_64 AMD A6-9500 RADEON R5, 8 COMPUTE CORES 2C+6G AuthenticAMD GNU/LinuxIt has cups 2.2.6 installed with a Brother HL1200 printer connected. Some mechanical issue with the printer made me install a backup HP1020 printer. After unsuccesfully experimenting and encountering the weirdest error messages, I decided to remove cups and hplip, whatever other print related things, and I re-installed cups, cups-filters, foo2zjs (compiled & installed), downloaded the firmware for the HP1020 (and uploaded it to the printer manually, as I could not find anything related in dmesg)...
According to cups, all is well - it accepts jobs, marks them as 'done', etc.
But nothing appears on paper. I checked the following:
# lpstat -a
HP_LaserJet_1020 accepting requests since Wed 20 Dec 2023 08:59:45 PM -03
Code:[43399.769537] usblp0: removed
[43407.817932] usblp 1-3:1.0: usblp0: USB Bidirectional printer dev 4 if 0 alt 0 proto 2 vid 0x03F0 pid 0x2B17
[43490.479166] usblp0: removed
[43498.685250] usblp 1-3:1.0: usblp0: USB Bidirectional printer dev 4 if 0 alt 0 proto 2 vid 0x03F0 pid 0x2B17
[45481.209572] usblp0: removedThis repeats - I think each print command.
The following is the error_log of cups. There are a couple (bolded) things I find suspicious, but I don't see a definite stop...
Code:D [20/Dec/2023:20:59:53 -0300] [Job 7] PID 9307 (pstops) exited with no errors.
D [20/Dec/2023:20:59:53 -0300] [Job 7] PID 9306 (pdftops) exited with no errors.
D [20/Dec/2023:20:59:53 -0300] [Job 7] Waiting for read thread to exit...
D [20/Dec/2023:20:59:53 -0300] [Job 7] Read thread still active, aborting the pending read...
D [20/Dec/2023:20:59:53 -0300] [Job 7] PID 9300 (/usr/lib64/cups/backend/usb) exited with no errors.
D [20/Dec/2023:20:59:53 -0300] [Job 7] End of messages
D [20/Dec/2023:20:59:53 -0300] [Job 7] printer-state=3(idle)
D [20/Dec/2023:20:59:53 -0300] [Job 7] printer-state-message="Filter failed"
D [20/Dec/2023:20:59:53 -0300] [Job 7] printer-state-reasons=none
E [20/Dec/2023:21:07:22 -0300] [Job 8] Job stopped due to filter errors; please consult the error_log file for details.
D [20/Dec/2023:21:07:22 -0300] [Job 8] The following messages were recorded from 21:07:14 to 21:07:22
D [20/Dec/2023:21:07:22 -0300] [Job 8] Applying default options...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Adding start banner page "none".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Queued on "HP_LaserJet_1020" by "root".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Auto-typing file...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Request file type is text/plain.
D [20/Dec/2023:21:07:22 -0300] [Job 8] File of type text/plain queued by "root".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Adding end banner page "none".
D [20/Dec/2023:21:07:22 -0300] [Job 8] time-at-processing=1703117234
D [20/Dec/2023:21:07:22 -0300] [Job 8] 3 filters for job:
D [20/Dec/2023:21:07:22 -0300] [Job 8] texttopdf (text/plain to application/pdf, cost 32)
D [20/Dec/2023:21:07:22 -0300] [Job 8] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [20/Dec/2023:21:07:22 -0300] [Job 8] foomatic-rip (application/vnd.cups-pdf to printer/HP_LaserJet_1020, cost 0)
D [20/Dec/2023:21:07:22 -0300] [Job 8] job-sheets=none,none
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[0]="HP_LaserJet_1020"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[1]="8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[2]="root"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[3]="hosts"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[4]="1"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1703117234 time-at-processing=1703117234 document-name-supplied=hosts"
D [20/Dec/2023:21:07:22 -0300] [Job 8] argv[6]="/var/spool/cups/d00008-001"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[2]="CUPS_DOCROOT=/usr/share/doc/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[5]="CUPS_SERVERBIN=/usr/lib64/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[8]="HOME=/var/spool/cups/tmp"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[9]="PATH=/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[10]="SERVER_ADMIN=root@sally.sklein.com"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[11]="SOFTWARE=CUPS/2.2.8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[13]="USER=root"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[14]="CUPS_MAX_MESSAGE=2047"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[17]="IPP_PORT=631"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[18]="CHARSET=utf-8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[19]="LANG=en_US.UTF-8"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[20]="PPD=/etc/cups/ppd/HP_LaserJet_1020.ppd"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[21]="RIP_MAX_CACHE=128m"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[22]="CONTENT_TYPE=text/plain"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[23]="DEVICE_URI=usb://HP/LaserJet%201020?serial=FZ05MV6"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[24]="PRINTER_INFO=HP LaserJet 1020"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[25]="PRINTER_LOCATION=sally"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[26]="PRINTER=HP_LaserJet_1020"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[27]="PRINTER_STATE_REASONS=none"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[28]="CUPS_FILETYPE=document"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-pdf"
D [20/Dec/2023:21:07:22 -0300] [Job 8] envp[30]="AUTH_I****"
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter /usr/lib64/cups/filter/texttopdf (PID 12319)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter /usr/lib64/cups/filter/pdftopdf (PID 12320)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter /usr/lib64/cups/filter/foomatic-rip (PID 12321)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started backend /usr/lib64/cups/backend/usb (PID 12322)
D [20/Dec/2023:21:07:22 -0300] [Job 8] pdftopdf: Last filter determined by the PPD: foomatic-rip; FINAL_CONTENT_TYPE: application/vnd.cups-pdf => pdftopdf will log pages in page_log.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Page = 595x842; 11,11 to 584,831
D [20/Dec/2023:21:07:22 -0300] [Job 8] Loading USB quirks from \"/usr/share/cups/usb\".
D [20/Dec/2023:21:07:22 -0300] [Job 8] Loaded 162 quirks.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printing on printer with URI: usb://HP/LaserJet%201020?serial=FZ05MV6
D [20/Dec/2023:21:07:22 -0300] [Job 8] Calling FindDeviceById(cups-HP_LaserJet_1020)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Failed to send: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [20/Dec/2023:21:07:22 -0300] [Job 8] Failed to get find device cups-HP_LaserJet_1020
D [20/Dec/2023:21:07:22 -0300] [Job 8] \'CM Color Calibration\' Mode in SPOOLER-LESS: Off
D [20/Dec/2023:21:07:22 -0300] [Job 8] Getting input from file
D [20/Dec/2023:21:07:22 -0300] [Job 8] foomatic-rip version 1.21.0 running...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Parsing PPD file ...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option ColorSpace
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option PageSize
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Quality
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Resolution
D [20/Dec/2023:21:07:22 -0300] [Job 8] libusb_get_device_list=10
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option ImageableArea
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option PaperDimension
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option InputSlot
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option MediaType
D [20/Dec/2023:21:07:22 -0300] [Job 8] STATE: +connecting-to-device
D [20/Dec/2023:21:07:22 -0300] [Job 8] STATE: -connecting-to-device
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Density
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Copies
D [20/Dec/2023:21:07:22 -0300] [Job 8] PAGE: 1 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12319 (/usr/lib64/cups/filter/texttopdf) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer found with device ID: MFG:Hewlett-Packard;MDL:HP LaserJet 1020;CMD:ACL;CLS:PRINTER;DES:HP LaserJet 1020;FWVER:20050309; Device URI: usb://HP/LaserJet%201020?serial=FZ05MV6
D [20/Dec/2023:21:07:22 -0300] [Job 8] Device protocol: 2
D [20/Dec/2023:21:07:22 -0300] [Job 8] Sending data to printer.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option halftone
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option NupOrient
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option NupPages
D [20/Dec/2023:21:07:22 -0300] [Job 8] Added option Font
D [20/Dec/2023:21:07:22 -0300] [Job 8] Parameter Summary
D [20/Dec/2023:21:07:22 -0300] [Job 8] -----------------
D [20/Dec/2023:21:07:22 -0300] [Job 8] Spooler: cups
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer: HP_LaserJet_1020
D [20/Dec/2023:21:07:22 -0300] [Job 8] Shell: /bin/bash
D [20/Dec/2023:21:07:22 -0300] [Job 8] PPD file: /etc/cups/ppd/HP_LaserJet_1020.ppd
D [20/Dec/2023:21:07:22 -0300] [Job 8] ATTR file:
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer model: HP LaserJet 1020 Foomatic/foo2zjs-z1 (recommended)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Job title: hosts
D [20/Dec/2023:21:07:22 -0300] [Job 8] File(s) to be printed:
D [20/Dec/2023:21:07:22 -0300] [Job 8] <STDIN>
D [20/Dec/2023:21:07:22 -0300] [Job 8] Ghostscript extra search path (\'GS_LIB\'): /usr/share/cups/fonts
D [20/Dec/2023:21:07:22 -0300] [Job 8] Value \" V\" for option \"Copies\", parameter \"Copies\" is smaller than the minimum value \"1\"
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printing system options:
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'finishings=3\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option finishings=3.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'number-up=1\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option number-up=1.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'job-originating-host-name=localhost\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option job-originating-host-name=localhost.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'date-time-at-creation=\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option date-time-at-creation=.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'date-time-at-processing=\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option date-time-at-processing=.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'time-at-creation=1703117234\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option time-at-creation=1703117234.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'time-at-processing=1703117234\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option time-at-processing=1703117234.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Pondering option \'document-name-supplied=hosts\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Unknown option document-name-supplied=hosts.
D [20/Dec/2023:21:07:22 -0300] [Job 8] CM Color Calibration Mode in CUPS: Off
D [20/Dec/2023:21:07:22 -0300] [Job 8] Options from the PPD file:
D [20/Dec/2023:21:07:22 -0300] [Job 8] ================================================
D [20/Dec/2023:21:07:22 -0300] [Job 8] File: <STDIN>
D [20/Dec/2023:21:07:22 -0300] [Job 8] ================================================
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12320 (/usr/lib64/cups/filter/pdftopdf) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Filetype: PDF
D [20/Dec/2023:21:07:22 -0300] [Job 8] Neither PDF renderer command line nor Ghostscript-based renderer command line found
D [20/Dec/2023:21:07:22 -0300] [Job 8] Driver does not understand PDF input, converting to PostScript
D [20/Dec/2023:21:07:22 -0300] [Job 8] Storing temporary files in /var/spool/cups/tmp
D [20/Dec/2023:21:07:22 -0300] [Job 8] Starting process \"pdf-to-ps\" (generation 1)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Printer make and model: HP HP LaserJet 1020
D [20/Dec/2023:21:07:22 -0300] [Job 8] Switching to Poppler\'s pdftops instead of Ghostscript for old HP LaserJet (\"LaserJet <number>\", no letters before <number>) printers to work around bugs in the printer\'s PS interpreters
D [20/Dec/2023:21:07:22 -0300] [Job 8] Running command line for pstops: pstops 8 root hosts 1 \' finishings=3 job-uuid=urn:uuid:30928143-629c-3bb0-65a6-a2659e00de33 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1703117234 time-at-processing=1703117234 document-name-supplied=hosts\'
D [20/Dec/2023:21:07:22 -0300] [Job 8] Using image rendering resolution 600 dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Running command line for pdftops: pdftops -level2 -origpagesizes -nocenter -r 600 /var/spool/cups/tmp/foomatic-dzPx2o -
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter pdftops (PID 12328)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Started filter pstops (PID 12329)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Page = 595x842; 11,11 to 584,831
D [20/Dec/2023:21:07:22 -0300] [Job 8] slow_collate=0, slow_duplex=0, slow_order=0
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before copy_comments - %!PS-Adobe-3.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] %!PS-Adobe-3.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] %Produced by poppler pdftops version: 0.68.0 (http://poppler.freedesktop.org)
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%Creator: texttopdf/1.21.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%LanguageLevel: 2
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%DocumentSuppliedResources: (atend)
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%DocumentMedia: A4 595 842 0 () ()
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%BoundingBox: 0 0 595 842
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%Pages: 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] %%EndComments
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before copy_prolog - %%BeginProlog
D [20/Dec/2023:21:07:22 -0300] [Job 8] Filetype: PostScript
D [20/Dec/2023:21:07:22 -0300] [Job 8] Reading PostScript input ...
D [20/Dec/2023:21:07:22 -0300] [Job 8] --> This document is DSC-conforming!
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found %RBINumCopies: 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] -----------
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginProlog
D [20/Dec/2023:21:07:22 -0300] [Job 8] Inserting option code into \"Prolog\" section.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before copy_setup - %%BeginSetup
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%EndProlog
D [20/Dec/2023:21:07:22 -0300] [Job 8] -----------
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginSetup
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginFeature: *Quality normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Quality=normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %% FoomaticRIPOptionSetting: Quality=normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Quality=normal
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginFeature: *halftone default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: halftone=default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %% FoomaticRIPOptionSetting: halftone=default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: halftone=default
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %%BeginFeature: *Resolution 1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Resolution=1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Setting option
D [20/Dec/2023:21:07:22 -0300] [Job 8] Found: %% FoomaticRIPOptionSetting: Resolution=1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] Option: Resolution=1200x600dpi
D [20/Dec/2023:21:07:22 -0300] [Job 8] double free or corruption (fasttop)
D [20/Dec/2023:21:07:22 -0300] [Job 8] Sent 0 bytes...
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12321 (/usr/lib64/cups/filter/foomatic-rip) crashed on signal 6.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Hint: Try setting the LogLevel to "debug" to find out more.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Before page loop - %%Page: 1 1
D [20/Dec/2023:21:07:22 -0300] [Job 8] Copying page 1...
D [20/Dec/2023:21:07:22 -0300] [Job 8] pagew = 572.3, pagel = 819.3
D [20/Dec/2023:21:07:22 -0300] [Job 8] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [20/Dec/2023:21:07:22 -0300] [Job 8] PageLeft = 11.3, PageRight = 583.7
D [20/Dec/2023:21:07:22 -0300] [Job 8] PageTop = 830.7, PageBottom = 11.3
D [20/Dec/2023:21:07:22 -0300] [Job 8] PageWidth = 595.0, PageLength = 842.0
D [20/Dec/2023:21:07:22 -0300] [Job 8] Wrote 1 pages...
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12329 (pstops) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12328 (pdftops) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] Waiting for read thread to exit...
D [20/Dec/2023:21:07:22 -0300] [Job 8] Read thread still active, aborting the pending read...
D [20/Dec/2023:21:07:22 -0300] [Job 8] PID 12322 (/usr/lib64/cups/backend/usb) exited with no errors.
D [20/Dec/2023:21:07:22 -0300] [Job 8] End of messages
D [20/Dec/2023:21:07:22 -0300] [Job 8] printer-state=3(idle)
D [20/Dec/2023:21:07:22 -0300] [Job 8] printer-state-message="Filter failed"
D [20/Dec/2023:21:07:22 -0300] [Job 8] printer-state-reasons=noneThe CUPS page marks the job with 'Filter failed'. Again, after a lot of tests, I could
not pinpoint any problem, except for the bold ones above.
Help!
John