LinuxQuestions.org

LinuxQuestions.org (/questions/)
-   Linux - Hardware (https://www.linuxquestions.org/questions/linux-hardware-18/)
-   -   usb printer will not print multi-page PDF (https://www.linuxquestions.org/questions/linux-hardware-18/usb-printer-will-not-print-multi-page-pdf-4175660798/)

byebyemrgates 09-12-2019 10:09 AM

usb printer will not print multi-page PDF
 
Hi there! Using Linux Mint 19
Epson Aculaser 1100 on USB port - will not print multi-page PDF, gives an error. All other printing ok.
Any suggestions? Thanks!
(installation of the printer was described in my last post: https://www.linuxquestions.org/quest...8/
I may have messed it up - complete newbie)
Error log:
Code:

E [13/Sep/2019:00:49:16 +1000] [Job 258] Job stopped due to filter errors; please consult the error_log file for details.
D [13/Sep/2019:00:49:16 +1000] [Job 258] The following messages were recorded from 00:49:07 to 00:49:16
D [13/Sep/2019:00:49:16 +1000] [Job 258] Applying default options...
D [13/Sep/2019:00:49:16 +1000] [Job 258] Adding default usb-no-reattach=true
D [13/Sep/2019:00:49:16 +1000] [Job 258] Adding start banner page "none".
D [13/Sep/2019:00:49:16 +1000] [Job 258] Adding end banner page "none".
D [13/Sep/2019:00:49:16 +1000] [Job 258] File of type application/pdf queued by "bekor".
D [13/Sep/2019:00:49:16 +1000] [Job 258] hold_until=0
D [13/Sep/2019:00:49:16 +1000] [Job 258] Queued on "EPSON-AL-C1100" by "bekor".
D [13/Sep/2019:00:49:16 +1000] [Job 258] time-at-processing=1568299747
D [13/Sep/2019:00:49:16 +1000] [Job 258] 3 filters for job:
D [13/Sep/2019:00:49:16 +1000] [Job 258] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [13/Sep/2019:00:49:16 +1000] [Job 258] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [13/Sep/2019:00:49:16 +1000] [Job 258] foomatic-rip (application/vnd.cups-postscript to printer/EPSON-AL-C1100, cost 0)
D [13/Sep/2019:00:49:16 +1000] [Job 258] job-sheets=none,none
D [13/Sep/2019:00:49:16 +1000] [Job 258] argv[0]="EPSON-AL-C1100"
D [13/Sep/2019:00:49:16 +1000] [Job 258] argv[1]="258"
D [13/Sep/2019:00:49:16 +1000] [Job 258] argv[2]="bekor"
D [13/Sep/2019:00:49:16 +1000] [Job 258] argv[3]="Volume14Issue6A4.pdf"
D [13/Sep/2019:00:49:16 +1000] [Job 258] argv[4]="1"
D [13/Sep/2019:00:49:16 +1000] [Job 258] argv[5]="number-up=1 TonerSave=Default noCollate Duplex=DuplexNoTumble Resolution=300dpi InputSlot=autoselection PageSize=A4 Color=color MediaType=normal job-uuid=urn:uuid:449a6843-8a08-3f2e-4e44-73da341b72e7 usb-no-reattach job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1568299747 time-at-processing=1568299747"
D [13/Sep/2019:00:49:16 +1000] [Job 258] argv[6]="/var/spool/cups/d00258-001"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[7]="CUPS_STATEDIR=/run/cups"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[8]="HOME=/var/spool/cups/tmp"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[10]="SERVER_ADMIN=root@Linux1"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[11]="SOFTWARE=CUPS/2.2.7"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[13]="USER=root"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[14]="CUPS_MAX_MESSAGE=2047"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[17]="IPP_PORT=631"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[18]="CHARSET=utf-8"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[19]="LANG=en_AU.UTF-8"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[20]="PPD=/etc/cups/ppd/EPSON-AL-C1100.ppd"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[21]="RIP_MAX_CACHE=128m"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[22]="CONTENT_TYPE=application/pdf"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[23]="DEVICE_URI=usb://EPSON/AL-C1100?serial=31PF9FZ12399561123"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[24]="PRINTER_INFO=EPSON AL-C1100"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[25]="PRINTER_LOCATION=Linux1"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[26]="PRINTER=EPSON-AL-C1100"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[27]="PRINTER_STATE_REASONS=none"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[28]="CUPS_FILETYPE=document"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [13/Sep/2019:00:49:16 +1000] [Job 258] envp[30]="AUTH_I****"
D [13/Sep/2019:00:49:16 +1000] [Job 258] Started filter /usr/lib/cups/filter/pdftopdf (PID 4223)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Started filter /usr/lib/cups/filter/pdftops (PID 4224)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Started filter /usr/lib/cups/filter/foomatic-rip (PID 4225)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Started backend /usr/lib/cups/backend/usb (PID 4226)
D [13/Sep/2019:00:49:16 +1000] [Job 258] pdftops - copying to temp print file \"/tmp/010805d88d2df\"
D [13/Sep/2019:00:49:16 +1000] [Job 258] Loading USB quirks from \"/usr/share/cups/usb\".
D [13/Sep/2019:00:49:16 +1000] [Job 258] Loaded 159 quirks.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Printing on printer with URI: usb://EPSON/AL-C1100?serial=31PF9FZ12399561123
D [13/Sep/2019:00:49:16 +1000] [Job 258] pdftopdf: Last filter determined by the PPD: foomatic-rip; FINAL_CONTENT_TYPE: application/vnd.cups-postscript => pdftopdf will log pages in page_log.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Calling FindDeviceById(cups-EPSON-AL-C1100)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found device /org/freedesktop/ColorManager/devices/cups_EPSON_AL_C1100
D [13/Sep/2019:00:49:16 +1000] [Job 258] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [13/Sep/2019:00:49:16 +1000] [Job 258] PAGE: 1 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] PAGE: 2 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] \'CM Color Calibration\' Mode in SPOOLER-LESS: Off
D [13/Sep/2019:00:49:16 +1000] [Job 258] Getting input from file
D [13/Sep/2019:00:49:16 +1000] [Job 258] foomatic-rip version 1.20.2 running...
D [13/Sep/2019:00:49:16 +1000] [Job 258] Parsing PPD file ...
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option ColorSpace
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option PageSize
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option ImageableArea
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option PaperDimension
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option MediaType
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option Color
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option Duplex
D [13/Sep/2019:00:49:16 +1000] [Job 258] libusb_get_device_list=9
D [13/Sep/2019:00:49:16 +1000] [Job 258] STATE: +connecting-to-device
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option TonerSave
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option Resolution
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option InputSlot
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option Collate
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option Copies
D [13/Sep/2019:00:49:16 +1000] [Job 258] STATE: -connecting-to-device
D [13/Sep/2019:00:49:16 +1000] [Job 258] Printer found with device ID: MFG:EPSON;CMD:EJL,ESCPAGES-03,D4L3;MDL:AL-C1100;CLS:PRINTER;DES:EPSON AL-C1100; Device URI: usb://EPSON/AL-C1100?serial=31PF9FZ12399561123
D [13/Sep/2019:00:49:16 +1000] [Job 258] Device protocol: 2
D [13/Sep/2019:00:49:16 +1000] [Job 258] Forced not re-attaching the usblp kernel module after the job via \"usb-no-reattach\" option.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Sending data to printer.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [13/Sep/2019:00:49:16 +1000] [Job 258] Added option Font
D [13/Sep/2019:00:49:16 +1000] [Job 258] Parameter Summary
D [13/Sep/2019:00:49:16 +1000] [Job 258] -----------------
D [13/Sep/2019:00:49:16 +1000] [Job 258] Spooler: cups
D [13/Sep/2019:00:49:16 +1000] [Job 258] Printer: EPSON-AL-C1100
D [13/Sep/2019:00:49:16 +1000] [Job 258] Shell: /bin/sh
D [13/Sep/2019:00:49:16 +1000] [Job 258] PPD file: /etc/cups/ppd/EPSON-AL-C1100.ppd
D [13/Sep/2019:00:49:16 +1000] [Job 258] ATTR file:
D [13/Sep/2019:00:49:16 +1000] [Job 258] Printer model: EPSON AL-C1100, ESC/PageS Filter
D [13/Sep/2019:00:49:16 +1000] [Job 258] Job title: Volume14Issue6A4.pdf
D [13/Sep/2019:00:49:16 +1000] [Job 258] File(s) to be printed:
D [13/Sep/2019:00:49:16 +1000] [Job 258] <STDIN>
D [13/Sep/2019:00:49:16 +1000] [Job 258] Ghostscript extra search path (\'GS_LIB\'): /usr/share/cups/fonts
D [13/Sep/2019:00:49:16 +1000] [Job 258] Printing system options:
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'number-up=1\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown option number-up=1.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'job-uuid=urn:uuid:449a6843-8a08-3f2e-4e44-73da341b72e7\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown option job-uuid=urn:uuid:449a6843-8a08-3f2e-4e44-73da341b72e7.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'usb-no-reattach\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown boolean option \"usb-no-reattach\".
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'job-originating-host-name=localhost\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown option job-originating-host-name=localhost.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'date-time-at-creation=\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown option date-time-at-creation=.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'date-time-at-processing=\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown option date-time-at-processing=.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'time-at-creation=1568299747\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown option time-at-creation=1568299747.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'time-at-processing=1568299747\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Unknown option time-at-processing=1568299747.
D [13/Sep/2019:00:49:16 +1000] [Job 258] CM Color Calibration Mode in CUPS: Off
D [13/Sep/2019:00:49:16 +1000] [Job 258] Options from the PPD file:
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'TonerSave=Default\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] invalid choice \"Default\", using \"false\" instead
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'noCollate\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'Duplex=DuplexNoTumble\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'Resolution=300dpi\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'InputSlot=autoselection\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'PageSize=A4\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'Color=color\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Pondering option \'MediaType=normal\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] ================================================
D [13/Sep/2019:00:49:16 +1000] [Job 258] File: <STDIN>
D [13/Sep/2019:00:49:16 +1000] [Job 258] ================================================
D [13/Sep/2019:00:49:16 +1000] [Job 258] PID 4223 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Printer make and model: Epson ESC/PageS Filter
D [13/Sep/2019:00:49:16 +1000] [Job 258] Running command line for pstops: pstops 258 bekor Volume14Issue6A4.pdf 1 \'TonerSave=Default Duplex=DuplexNoTumble Resolution=300dpi InputSlot=autoselection PageSize=A4 Color=color MediaType=normal job-uuid=urn:uuid:449a6843-8a08-3f2e-4e44-73da341b72e7 usb-no-reattach job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1568299747 time-at-processing=1568299747\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] Using image rendering resolution 300 dpi
D [13/Sep/2019:00:49:16 +1000] [Job 258] Running command line for gs: gs -q -dNOPAUSE -dBATCH -dSAFER -dNOMEDIAATTRS -sDEVICE=ps2write -dShowAcroForm -sOUTPUTFILE=%stdout -dLanguageLevel=3 -r300 -dCompressFonts=false -dNoT3CCITT -dNOINTERPOLATE -c \'save pop\' -f /tmp/010805d88d2df
D [13/Sep/2019:00:49:16 +1000] [Job 258] Started filter gs (PID 4232)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Started filter pstops (PID 4233)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Page = 595x842; 0,0 to 595,842
D [13/Sep/2019:00:49:16 +1000] [Job 258] slow_collate=0, slow_duplex=0, slow_order=0
D [13/Sep/2019:00:49:16 +1000] [Job 258] Before copy_comments - %!PS-Adobe-3.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] %!PS-Adobe-3.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] %%BoundingBox: 0 0 596 842
D [13/Sep/2019:00:49:16 +1000] [Job 258] %%HiResBoundingBox: 0 0 596.00 842.00
D [13/Sep/2019:00:49:16 +1000] [Job 258] %%Creator: GPL Ghostscript 926 (ps2write)
D [13/Sep/2019:00:49:16 +1000] [Job 258] %%LanguageLevel: 2
D [13/Sep/2019:00:49:16 +1000] [Job 258] %%CreationDate: D:20190913004907+10\'00\'
D [13/Sep/2019:00:49:16 +1000] [Job 258] %%Pages: 2
D [13/Sep/2019:00:49:16 +1000] [Job 258] %%EndComments
D [13/Sep/2019:00:49:16 +1000] [Job 258] Before copy_prolog - %%BeginProlog
D [13/Sep/2019:00:49:16 +1000] [Job 258] Filetype: PostScript
D [13/Sep/2019:00:49:16 +1000] [Job 258] Reading PostScript input ...
D [13/Sep/2019:00:49:16 +1000] [Job 258] --> This document is DSC-conforming!
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found %RBINumCopies: 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] -----------
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginProlog
D [13/Sep/2019:00:49:16 +1000] [Job 258] Before copy_setup - %%Page: 1 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Before page loop - %%Page: 1 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Copying page 1...
D [13/Sep/2019:00:49:16 +1000] [Job 258] pagew = 595.0, pagel = 842.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [13/Sep/2019:00:49:16 +1000] [Job 258] PageLeft = 0.0, PageRight = 595.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] PageTop = 842.0, PageBottom = 0.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] PageWidth = 595.0, PageLength = 842.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] Copying page 2...
D [13/Sep/2019:00:49:16 +1000] [Job 258] pagew = 595.0, pagel = 842.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [13/Sep/2019:00:49:16 +1000] [Job 258] PageLeft = 0.0, PageRight = 595.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] PageTop = 842.0, PageBottom = 0.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] PageWidth = 595.0, PageLength = 842.0
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%EndProlog
D [13/Sep/2019:00:49:16 +1000] [Job 258] -----------
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginSetup
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *Collate on
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Collate=on
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: Collate=on
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Collate=on
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *Copies 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Copies=1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: Copies=1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Copies=1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *InputSlot autoselection
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: InputSlot=autoselection
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: InputSlot=autoselection
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: InputSlot=autoselection
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *MediaType normal
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: MediaType=normal
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: MediaType=normal
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: MediaType=normal
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *PageSize a4
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: PageSize=a4
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: PageSize=a4
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: PageSize=a4
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *TonerSave false
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: TonerSave=false
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: TonerSave=false
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: TonerSave=false
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *Resolution 300dpi
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Resolution=300dpi
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: Resolution=300dpi
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Resolution=300dpi
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *Color color
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Color=color
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: Color=color
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Color=color
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginFeature: *Duplex DuplexNoTumble
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Duplex=DuplexNoTumble
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %% FoomaticRIPOptionSetting: Duplex=DuplexNoTumble
D [13/Sep/2019:00:49:16 +1000] [Job 258] Option: Duplex=DuplexNoTumble
D [13/Sep/2019:00:49:16 +1000] [Job 258] Setting option
D [13/Sep/2019:00:49:16 +1000] [Job 258] Wrote 2 pages...
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%EndSetup
D [13/Sep/2019:00:49:16 +1000] [Job 258] -----------
D [13/Sep/2019:00:49:16 +1000] [Job 258] New page: %%Page: 1 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] \"Setup\" section is missing, inserting it.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%BeginPageSetup
D [13/Sep/2019:00:49:16 +1000] [Job 258] Inserting option code into \"PageSetup\" section.
D [13/Sep/2019:00:49:16 +1000] [Job 258] New page found but previous not printed, print it now.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Found: %%Page: 2 2
D [13/Sep/2019:00:49:16 +1000] [Job 258] --> Output goes directly to the renderer now.
D [13/Sep/2019:00:49:16 +1000] [Job 258] PID 4232 (gs) exited with no errors.
D [13/Sep/2019:00:49:16 +1000] [Job 258] PID 4233 (pstops) exited with no errors.
D [13/Sep/2019:00:49:16 +1000] [Job 258] PID 4224 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Starting renderer with command: \"pstoalc1100.sh  Copies=1 Collate=on InputSlot=autoselection TonerSave=false MediaType=normal PageSize=a4 XY600=4960x7016 Resolution=300dpi Color=color Duplex=DuplexNoTumble\"
D [13/Sep/2019:00:49:16 +1000] [Job 258] Starting process \"kid3\" (generation 1)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Starting process \"kid4\" (generation 2)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Starting process \"renderer\" (generation 2)
D [13/Sep/2019:00:49:16 +1000] [Job 258] JCL: \033%-12345X@PJL
D [13/Sep/2019:00:49:16 +1000] [Job 258] <job data>
D [13/Sep/2019:00:49:16 +1000] [Job 258] Usage: pstops job-id user title copies options [file]
D [13/Sep/2019:00:49:16 +1000] [Job 258] renderer exited with status 0
D [13/Sep/2019:00:49:16 +1000] [Job 258] kid4 exited with status 0
D [13/Sep/2019:00:49:16 +1000] [Job 258] kid3 finished
D [13/Sep/2019:00:49:16 +1000] [Job 258] Process is dying with \"Encountered error Broken pipe during fwrite\", exit stat 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Cleaning up...
D [13/Sep/2019:00:49:16 +1000] [Job 258] Killing kid3
D [13/Sep/2019:00:49:16 +1000] [Job 258] Process is dying with \"Caught termination signal: Job canceled
D [13/Sep/2019:00:49:16 +1000] [Job 258] \", exit stat 0
D [13/Sep/2019:00:49:16 +1000] [Job 258] Cleaning up...
D [13/Sep/2019:00:49:16 +1000] [Job 258] PID 4225 (/usr/lib/cups/filter/foomatic-rip) stopped with status 1.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Hint: Try setting the LogLevel to "debug" to find out more.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Sent 0 bytes...
D [13/Sep/2019:00:49:16 +1000] [Job 258] Waiting for read thread to exit...
D [13/Sep/2019:00:49:16 +1000] [Job 258] PID 4226 (/usr/lib/cups/backend/usb) exited with no errors.
D [13/Sep/2019:00:49:16 +1000] [Job 258] End of messages
D [13/Sep/2019:00:49:16 +1000] [Job 258] printer-state=3(idle)
D [13/Sep/2019:00:49:16 +1000] [Job 258] printer-state-message="Filter failed"
D [13/Sep/2019:00:49:16 +1000] [Job 258] printer-state-reasons=none


ferrari 09-13-2019 07:17 PM

This part of the log shows foomatic-rip fails for some reason, and suggests putting CUPS into debug mode for more verbose output...
Code:

00:49:16 +1000] [Job 258] Starting renderer with command: \"pstoalc1100.sh  Copies=1 Collate=on InputSlot=autoselection TonerSave=false MediaType=normal PageSize=a4 XY600=4960x7016 Resolution=300dpi Color=color Duplex=DuplexNoTumble\"
D [13/Sep/2019:00:49:16 +1000] [Job 258] Starting process \"kid3\" (generation 1)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Starting process \"kid4\" (generation 2)
D [13/Sep/2019:00:49:16 +1000] [Job 258] Starting process \"renderer\" (generation 2)
D [13/Sep/2019:00:49:16 +1000] [Job 258] JCL: \033%-12345X@PJL
D [13/Sep/2019:00:49:16 +1000] [Job 258] <job data>
D [13/Sep/2019:00:49:16 +1000] [Job 258] Usage: pstops job-id user title copies options [file]
D [13/Sep/2019:00:49:16 +1000] [Job 258] renderer exited with status 0
D [13/Sep/2019:00:49:16 +1000] [Job 258] kid4 exited with status 0
D [13/Sep/2019:00:49:16 +1000] [Job 258] kid3 finished
D [13/Sep/2019:00:49:16 +1000] [Job 258] Process is dying with \"Encountered error Broken pipe during fwrite\", exit stat 1
D [13/Sep/2019:00:49:16 +1000] [Job 258] Cleaning up...
D [13/Sep/2019:00:49:16 +1000] [Job 258] Killing kid3
D [13/Sep/2019:00:49:16 +1000] [Job 258] Process is dying with \"Caught termination signal: Job canceled
D [13/Sep/2019:00:49:16 +1000] [Job 258] \", exit stat 0
D [13/Sep/2019:00:49:16 +1000] [Job 258] Cleaning up...
D [13/Sep/2019:00:49:16 +1000] [Job 258] PID 4225 (/usr/lib/cups/filter/foomatic-rip) stopped with status 1.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Hint: Try setting the LogLevel to "debug" to find out more.
D [13/Sep/2019:00:49:16 +1000] [Job 258] Sent 0 bytes...

To do that do
Code:

sudo cupsctl --debug-logging
then try sending another print job and observe the error_log. It may well be that a bug report is required to help resolve such anissue.

Shadow_7 09-14-2019 03:54 AM

I tend to use a2ps to convert pdf's to single pages (.ps files) and print each page that way. Granted that I use gimp to print and need to adjust the image to B&W since my color ink is out and no longer sold for my model of printer.

byebyemrgates 09-15-2019 09:14 PM

No solution fund, even via Mint Forum.
Thanks anyway

ferrari 09-15-2019 10:51 PM

Ok, but did you try capturing more verbose error_log information for further analysis?


All times are GMT -5. The time now is 01:50 AM.