[SOLVED] usb printer will not print multi-page PDF
Linux - HardwareThis forum is for Hardware issues.
Having trouble installing a piece of hardware? Want to know if that peripheral is compatible with Linux?
Notices
Welcome to LinuxQuestions.org, a friendly and active Linux Community.
You are currently viewing LQ as a guest. By joining our community you will have the ability to post topics, receive our newsletter, use the advanced search, subscribe to threads and access many other special features. Registration is quick, simple and absolutely free. Join our community today!
Note that registered members see fewer ads, and ContentLink is completely disabled once you log in.
If you have any problems with the registration process or your account login, please contact us. If you need to reset your password, click here.
Having a problem logging in? Please visit this page to clear all LQ-related cookies.
Get a virtual cloud desktop with the Linux distro that you want in less than five minutes with Shells! With over 10 pre-installed distros to choose from, the worry-free installation life is here! Whether you are a digital nomad or just looking for flexibility, Shells can put your Linux machine on the device that you want to use.
Exclusive for LQ members, get up to 45% off per month. Click here for more info.
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/#post6035139
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
Last edited by byebyemrgates; 09-12-2019 at 03:15 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.
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.
LinuxQuestions.org is looking for people interested in writing
Editorials, Articles, Reviews, and more. If you'd like to contribute
content, let us know.
usb printer will not print multi-page PDF
