[SOLVED] USB-connected Lexmark printer SOMETIMES prints error pages from MXLinux
Linux - NewbieThis Linux forum is for members that are new to Linux.
Just starting out and have a question?
If it is not in the man pages or the how-to's this is the place!
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.
USB-connected Lexmark printer SOMETIMES prints error pages from MXLinux
Hello everyone!
I have never made a forum post in my life, but I guess there is a first time for everything.
NOTE: I am helping a friend and do not have direct access to the laptops and printers in question. So applying your wonderful help will take some time each time. Thank you for your patience!
The Setup:
- two Lexmark printers C317dn, C746dn with newest firmware
- several laptops with most recent MXLinux + drivers provided by Lexmark themselves
The Problem:
- both printers sometimes start printing an error page instead of the supposed output
- other documents or repeated attempts might yield the supposed page - might not
The integers stay the same for the same document and different page sizes but change to a different fixed set of numbers once the option "adjust to page size" (in qpdfview) is ticked.
Where does this leave me:
- I know almost nothing
- the log shows that 2 of 2 pages are processed and sent but then only one error page gets printed
- the Internet says "setpagedevice" error on the printed page refers to a PostScript and presumably underlying driver error
- someone on this forum had the same error a couple of years ago and was able to solve it by explicitly setting US letter or A4 in their pdf viewer - I tried both and it changed nothing
With cupsd debugging logging enabled, /var/log/cups/error_log reads for print job 194 as follows (empty lines mean I deleted a couple of hundred read/write lines for "brevity"):
Code:
D [13/Nov/2023:15:53:39 +0100] [Job 194] Applying default options...
D [13/Nov/2023:15:53:39 +0100] add_job: requesting-user-name="UwebeA"
I [13/Nov/2023:15:53:39 +0100] [Job 194] Adding start banner page "none".
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [13/Nov/2023:15:53:39 +0100] [Job 194] Queued on "Lexmark-Lexmark-C740-Series" by "UwebeA".
D [13/Nov/2023:15:53:39 +0100] [Client 779] Returning IPP successful-ok for Create-Job (ipp://localhost/printers/Lexmark-Lexmark-C740-Series) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 779] Content-Length: 201
D [13/Nov/2023:15:53:39 +0100] [Client 779] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 779] con->http=0x55933aa21e50
D [13/Nov/2023:15:53:39 +0100] [Client 779] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=201, response=0x55933aa287d0(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 779] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 779] bytes=0, http_state=0, data_remaining=201
D [13/Nov/2023:15:53:39 +0100] [Client 779] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 779] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 779] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] JobCreated
D [13/Nov/2023:15:53:39 +0100] [Client 779] POST /printers/Lexmark-Lexmark-C740-Series HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 779] 2.0 Send-Document 193
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 779] Read: status=100, state=6
D [13/Nov/2023:15:53:39 +0100] Send-Document ipp://localhost:631/printers/Lexmark-Lexmark-C740-Series
D [13/Nov/2023:15:53:39 +0100] cupsdIsAuthorized: requesting-user-name="UwebeA"
D [13/Nov/2023:15:53:39 +0100] [Job 194] Auto-typing file...
D [13/Nov/2023:15:53:39 +0100] [Job 194] Request file type is application/pdf.
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [13/Nov/2023:15:53:39 +0100] [Job 194] File of type application/pdf queued by "UwebeA".
I [13/Nov/2023:15:53:39 +0100] [Job 194] Adding end banner page "none".
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Job 194] time-at-processing=1699887219
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Job 194] 2 filters for job:
D [13/Nov/2023:15:53:39 +0100] [Job 194] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [13/Nov/2023:15:53:39 +0100] [Job 194] foomatic-rip (application/vnd.cups-pdf to printer/Lexmark-Lexmark-C740-Series, cost 0)
D [13/Nov/2023:15:53:39 +0100] [Job 194] job-sheets=none,none
D [13/Nov/2023:15:53:39 +0100] [Job 194] argv[0]="Lexmark-Lexmark-C740-Series"
D [13/Nov/2023:15:53:39 +0100] [Job 194] argv[1]="194"
D [13/Nov/2023:15:53:39 +0100] [Job 194] argv[2]="UwebeA"
D [13/Nov/2023:15:53:39 +0100] [Job 194] argv[3]="002_Schreiben_001_7bad0d76-034c-41f4-a16b-5558aeca6cd2"
D [13/Nov/2023:15:53:39 +0100] [Job 194] argv[4]="1"
D [13/Nov/2023:15:53:39 +0100] [Job 194] argv[5]="noCollate finishings=3 fit-to-page Ink=COLOR job-billing= nolandscape number-up=1 number-up-layout=lrtb outputorder=normal page-ranges=1-2 sides=one-sided job-uuid=urn:uuid:2a2ba028-6e98-3325-4440-fabf9dcde55d job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1699887219 time-at-processing=1699887219 document-name-supplied=qpdfview.BHVzBK.pdf Duplex=None"
D [13/Nov/2023:15:53:39 +0100] [Job 194] argv[6]="/var/spool/cups/d00194-001"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[7]="CUPS_STATEDIR=/run/cups"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[8]="HOME=/var/spool/cups/tmp"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[10]="SERVER_ADMIN=root@mxLinuxfuerbeA"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[11]="SOFTWARE=CUPS/2.3.3op2"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[13]="TZ=Europe/Berlin"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[14]="USER=root"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[15]="CUPS_MAX_MESSAGE=2047"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[16]="CUPS_SERVER=/run/cups/cups.sock"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[17]="CUPS_ENCRYPTION=IfRequested"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[18]="IPP_PORT=631"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[19]="CHARSET=utf-8"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[20]="LANG=de_DE.UTF-8"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[21]="PPD=/etc/cups/ppd/Lexmark-Lexmark-C740-Series.ppd"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[22]="RIP_MAX_CACHE=128m"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[23]="CONTENT_TYPE=application/pdf"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[24]="DEVICE_URI=usb://Lexmark/C740%20Series?serial=50262194239CR"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[25]="PRINTER_INFO=Lexmark Lexmark C740 Series"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[26]="PRINTER_LOCATION=mxLinuxfuerbeA"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[27]="PRINTER=Lexmark-Lexmark-C740-Series"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[28]="PRINTER_STATE_REASONS=none"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[29]="CUPS_FILETYPE=document"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[30]="FINAL_CONTENT_TYPE=application/vnd.cups-pdf"
D [13/Nov/2023:15:53:39 +0100] [Job 194] envp[31]="AUTH_I****"
I [13/Nov/2023:15:53:39 +0100] [Job 194] Started filter /usr/lib/cups/filter/pdftopdf (PID 16483)
I [13/Nov/2023:15:53:39 +0100] [Job 194] Started filter /usr/lib/cups/filter/foomatic-rip (PID 16484)
I [13/Nov/2023:15:53:39 +0100] [Job 194] Started backend /usr/lib/cups/backend/usb (PID 16485)
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 779] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Lexmark-Lexmark-C740-Series) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 779] Content-Length: 171
D [13/Nov/2023:15:53:39 +0100] [Client 779] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 779] con->http=0x55933aa21e50
D [13/Nov/2023:15:53:39 +0100] [Client 779] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=171, response=0x55933aa1ffe0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 779] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 779] bytes=0, http_state=0, data_remaining=171
D [13/Nov/2023:15:53:39 +0100] [Client 779] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 779] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 779] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] PrinterStateChanged
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] JobState
D [13/Nov/2023:15:53:39 +0100] [Job 194] Loading USB quirks from \"/usr/share/cups/usb\".
D [13/Nov/2023:15:53:39 +0100] [Job 194] Loaded 98 quirks.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Printing on printer with URI: usb://Lexmark/C740%20Series?serial=50262194239CR
D [13/Nov/2023:15:53:39 +0100] [Job 194] Calling FindDeviceById(cups-Lexmark-Lexmark-C740-Series)
D [13/Nov/2023:15:53:39 +0100] [Job 194] Found device /org/freedesktop/ColorManager/devices/cups_Lexmark_Lexmark_C740_Series
D [13/Nov/2023:15:53:39 +0100] [Job 194] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [13/Nov/2023:15:53:39 +0100] [Job 194] \'CM Color Calibration\' Mode in SPOOLER-LESS: Off
D [13/Nov/2023:15:53:39 +0100] [Job 194] Getting input from file
D [13/Nov/2023:15:53:39 +0100] [Job 194] foomatic-rip version 1.28.7 running...
D [13/Nov/2023:15:53:39 +0100] [Job 194] Parsing PPD file ...
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option ColorSpace
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option PageSize
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option ImageableArea
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option PaperDimension
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option InputSlot
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option Duplex
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option Resolution
D [13/Nov/2023:15:53:39 +0100] [Job 194] Added option Font
D [13/Nov/2023:15:53:39 +0100] [Job 194] pdftopdf: Last filter determined by the PPD: foomatic-rip; FINAL_CONTENT_TYPE: application/vnd.cups-pdf => pdftopdf will log pages in page_log.
W [13/Nov/2023:15:53:39 +0100] [Job 194] /var/spool/cups/d00194-001: extraneous whitespace seen before xref
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Job 194] Set job-printer-state-message to "/var/spool/cups/d00194-001: extraneous whitespace seen before xref", current level=WARN
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Job 194] Parameter Summary
D [13/Nov/2023:15:53:39 +0100] [Job 194] -----------------
D [13/Nov/2023:15:53:39 +0100] [Job 194] Spooler: cups
D [13/Nov/2023:15:53:39 +0100] [Job 194] Printer: Lexmark-Lexmark-C740-Series
D [13/Nov/2023:15:53:39 +0100] [Job 194] Shell: /bin/sh
D [13/Nov/2023:15:53:39 +0100] [Job 194] PPD file: /etc/cups/ppd/Lexmark-Lexmark-C740-Series.ppd
D [13/Nov/2023:15:53:39 +0100] [Job 194] ATTR file:
D [13/Nov/2023:15:53:39 +0100] [Job 194] Printer model: Lexmark C740 Foomatic/Postscript
D [13/Nov/2023:15:53:39 +0100] [Job 194] Job title: 002_Schreiben_001_7bad0d76-034c-41f4-a16b-5558aeca6cd2
D [13/Nov/2023:15:53:39 +0100] [Job 194] File(s) to be printed:
D [13/Nov/2023:15:53:39 +0100] [Job 194] <STDIN>
D [13/Nov/2023:15:53:39 +0100] [Job 194] Ghostscript extra search path (\'GS_LIB\'): /usr/share/cups/fonts
D [13/Nov/2023:15:53:39 +0100] [Job 194] Printing system options:
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'noCollate\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown boolean option \"noCollate\".
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'finishings=3\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option finishings=3.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'fit-to-page\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown boolean option \"fit-to-page\".
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'Ink=COLOR\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option Ink=COLOR.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'job-billing=\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option job-billing=.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'nolandscape\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown boolean option \"nolandscape\".
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'number-up=1\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option number-up=1.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'number-up-layout=lrtb\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option number-up-layout=lrtb.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'outputorder=normal\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option outputorder=normal.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'page-ranges=1-2\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option page-ranges=1-2.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'sides=one-sided\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'job-uuid=urn:uuid:2a2ba028-6e98-3325-4440-fabf9dcde55d\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option job-uuid=urn:uuid:2a2ba028-6e98-3325-4440-fabf9dcde55d.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'job-originating-host-name=localhost\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option job-originating-host-name=localhost.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'date-time-at-creation=\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option date-time-at-creation=.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'date-time-at-processing=\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option date-time-at-processing=.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'time-at-creation=1699887219\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option time-at-creation=1699887219.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'time-at-processing=1699887219\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option time-at-processing=1699887219.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'document-name-supplied=qpdfview.BHVzBK.pdf\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Unknown option document-name-supplied=qpdfview.BHVzBK.pdf.
D [13/Nov/2023:15:53:39 +0100] [Job 194] CM Color Calibration Mode in CUPS: Off
D [13/Nov/2023:15:53:39 +0100] [Job 194] Options from the PPD file:
D [13/Nov/2023:15:53:39 +0100] [Job 194] Pondering option \'Duplex=None\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] ================================================
D [13/Nov/2023:15:53:39 +0100] [Job 194] File: <STDIN>
D [13/Nov/2023:15:53:39 +0100] [Job 194] ================================================
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] JobProgress
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] PrinterStateChanged
D [13/Nov/2023:15:53:39 +0100] [Job 194] PDF interactive form and annotation flattening done via QPDF
D [13/Nov/2023:15:53:39 +0100] [Job 194] libusb_get_device_list=17
D [13/Nov/2023:15:53:39 +0100] [Job 194] STATE: +connecting-to-device
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [13/Nov/2023:15:53:39 +0100] [Job 194] STATE: -connecting-to-device
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] PrinterStateChanged
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] PrinterStateChanged
D [13/Nov/2023:15:53:39 +0100] [Job 194] Device protocol: 2
D [13/Nov/2023:15:53:39 +0100] [Job 194] Read 8 bytes of back-channel data...
D [13/Nov/2023:15:53:39 +0100] [Job 194] PAGE: 1 1
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] JobProgress
D [13/Nov/2023:15:53:39 +0100] [Job 194] PAGE: 2 1
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] JobProgress
D [13/Nov/2023:15:53:39 +0100] [Job 194] Filetype: PDF
D [13/Nov/2023:15:53:39 +0100] [Job 194] PostScript option found: PageSize=Letter: \"<</PageSize[612 792]/ImagingBBox null>>setpagedevice\"
D [13/Nov/2023:15:53:39 +0100] [Job 194] Driver does not understand PDF input, converting to PostScript
D [13/Nov/2023:15:53:39 +0100] [Job 194] Storing temporary files in /var/spool/cups/tmp
D [13/Nov/2023:15:53:39 +0100] [Job 194] Sende Daten zum Drucker.
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] JobProgress
D [13/Nov/2023:15:53:39 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:39 +0100] [Notifier] PrinterStateChanged
D [13/Nov/2023:15:53:39 +0100] [Job 194] PID 16483 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [13/Nov/2023:15:53:39 +0100] [Job 194] File contains 2 pages.
D [13/Nov/2023:15:53:39 +0100] [Job 194] Starting process \"pdf-to-ps\" (generation 1)
D [13/Nov/2023:15:53:39 +0100] [Job 194] Printer make and model: Lexmark Lexmark C740 Series
D [13/Nov/2023:15:53:39 +0100] [Job 194] Running command line for pstops: pstops 194 UwebeA 002_Schreiben_001_7bad0d76-034c-41f4-a16b-5558aeca6cd2 1 \' finishings=3 Ink=COLOR job-billing= sides=one-sided job-uuid=urn:uuid:2a2ba028-6e98-3325-4440-fabf9dcde55d job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1699887219 time-at-processing=1699887219 document-name-supplied=qpdfview.BHVzBK.pdf Duplex=None\'
D [13/Nov/2023:15:53:39 +0100] [Job 194] Using image rendering resolution 600 dpi
D [13/Nov/2023:15:53:39 +0100] [Job 194] Running command line for gs: gs -q -dNOPAUSE -dBATCH -dSAFER -dNOMEDIAATTRS -sstdout=%stderr -sDEVICE=ps2write -dShowAcroForm -sOUTPUTFILE=%stdout -dLanguageLevel=3 -r600 -dCompressFonts=false -dNoT3CCITT -dNOINTERPOLATE -c \'save pop\' -f /var/spool/cups/tmp/foomatic-AhWsgG
D [13/Nov/2023:15:53:39 +0100] [Job 194] Started filter gs (PID 16495)
D [13/Nov/2023:15:53:39 +0100] [Job 194] Started filter pstops (PID 16496)
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 780] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 780] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 780] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 780] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 780] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 780] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 780] 2.0 Get-Notifications 1598
D [13/Nov/2023:15:53:39 +0100] Get-Notifications /
D [13/Nov/2023:15:53:39 +0100] cupsdIsAuthorized: requesting-user-name="UwebeA"
D [13/Nov/2023:15:53:39 +0100] [Client 780] Returning IPP successful-ok for Get-Notifications (/) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 780] Content-Length: 6160
D [13/Nov/2023:15:53:39 +0100] [Client 780] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 780] con->http=0x55933aa767b0
D [13/Nov/2023:15:53:39 +0100] [Client 780] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6160, response=0x55933aabe8a0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 780] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 780] bytes=0, http_state=0, data_remaining=6160
D [13/Nov/2023:15:53:39 +0100] [Client 780] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 780] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 780] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 780] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 780] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 780] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 780] 2.0 Get-Job-Attributes 1599
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 780] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 780] Content-Length: 1394
D [13/Nov/2023:15:53:39 +0100] [Client 780] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 780] con->http=0x55933aa767b0
D [13/Nov/2023:15:53:39 +0100] [Client 780] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1394, response=0x55933aa98f90(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 780] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 780] bytes=0, http_state=0, data_remaining=1394
D [13/Nov/2023:15:53:39 +0100] [Client 780] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 780] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 780] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 781] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 781] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 781] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 781] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 781] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 781] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 781] 2.0 Get-Printer-Attributes 1600
D [13/Nov/2023:15:53:39 +0100] Get-Printer-Attributes
D [13/Nov/2023:15:53:39 +0100] Get-Printer-Attributes client-error-not-found: Der Drucker oder die Klasse existiert nicht.
D [13/Nov/2023:15:53:39 +0100] [Client 781] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 781] Content-Length: 138
D [13/Nov/2023:15:53:39 +0100] [Client 781] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 781] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 781] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=138, response=0x55933aa49db0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 781] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 781] bytes=0, http_state=0, data_remaining=138
D [13/Nov/2023:15:53:39 +0100] [Client 781] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 781] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 781] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 781] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 781] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 782] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 782] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 782] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 782] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 782] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 782] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 782] 2.0 Get-Job-Attributes 1601
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 782] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 782] Content-Length: 191
D [13/Nov/2023:15:53:39 +0100] [Client 782] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 782] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 782] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=191, response=0x55933aaa7020(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 782] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 782] bytes=0, http_state=0, data_remaining=191
D [13/Nov/2023:15:53:39 +0100] [Client 782] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 782] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 782] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 782] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 782] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 783] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 783] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 783] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 783] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 783] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 783] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 783] 2.0 Get-Job-Attributes 1602
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 783] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 783] Content-Length: 101
D [13/Nov/2023:15:53:39 +0100] [Client 783] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 783] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 783] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55933aa98f90(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 783] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 783] bytes=0, http_state=0, data_remaining=101
D [13/Nov/2023:15:53:39 +0100] [Client 783] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 783] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 783] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 784] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 784] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 784] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 784] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 784] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 784] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 784] 2.0 Get-Printer-Attributes 1603
D [13/Nov/2023:15:53:39 +0100] Get-Printer-Attributes ipp://mxLinuxfuerbeA/printers/Lexmark-Lexmark-C740-Series
D [13/Nov/2023:15:53:39 +0100] [Client 784] Returning IPP successful-ok for Get-Printer-Attributes (ipp://mxLinuxfuerbeA/printers/Lexmark-Lexmark-C740-Series) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 784] Content-Length: 139
D [13/Nov/2023:15:53:39 +0100] [Client 784] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 784] con->http=0x55933aac3380
D [13/Nov/2023:15:53:39 +0100] [Client 784] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=139, response=0x55933aa49db0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 784] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 784] bytes=0, http_state=0, data_remaining=139
D [13/Nov/2023:15:53:39 +0100] [Client 784] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 784] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 784] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 784] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 784] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 784] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 784] 2.0 Get-Job-Attributes 1604
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 784] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 784] Content-Length: 192
D [13/Nov/2023:15:53:39 +0100] [Client 784] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 784] con->http=0x55933aac3380
D [13/Nov/2023:15:53:39 +0100] [Client 784] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=192, response=0x55933aa31470(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 784] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 784] bytes=0, http_state=0, data_remaining=192
D [13/Nov/2023:15:53:39 +0100] [Client 784] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 784] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 784] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 783] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 783] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 785] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 785] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 785] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 785] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 785] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 785] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 785] 2.0 Get-Job-Attributes 1605
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 785] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 785] Content-Length: 101
D [13/Nov/2023:15:53:39 +0100] [Client 785] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 785] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 785] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55933aa98f90(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 785] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 785] bytes=0, http_state=0, data_remaining=101
D [13/Nov/2023:15:53:39 +0100] [Client 785] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 785] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 785] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 785] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 785] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 786] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 786] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 786] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 786] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 786] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 786] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 786] 2.0 Get-Job-Attributes 1606
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 786] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 786] Content-Length: 101
D [13/Nov/2023:15:53:39 +0100] [Client 786] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 786] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 786] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55933aaa7020(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 786] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 786] bytes=0, http_state=0, data_remaining=101
D [13/Nov/2023:15:53:39 +0100] [Client 786] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 786] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 786] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 786] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 786] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 787] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 787] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 787] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 787] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 787] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 787] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 787] 2.0 Get-Job-Attributes 1607
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 787] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 787] Content-Length: 101
D [13/Nov/2023:15:53:39 +0100] [Client 787] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 787] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 787] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55933aa287d0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 787] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 787] bytes=0, http_state=0, data_remaining=101
D [13/Nov/2023:15:53:39 +0100] [Client 787] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 787] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 787] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 787] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 787] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 788] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 788] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 788] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 788] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 788] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 788] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 788] 2.0 Get-Job-Attributes 1608
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 788] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 788] Content-Length: 101
D [13/Nov/2023:15:53:39 +0100] [Client 788] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 788] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 788] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55933aa98f90(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 788] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 788] bytes=0, http_state=0, data_remaining=101
D [13/Nov/2023:15:53:39 +0100] [Client 788] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 788] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 788] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 788] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 788] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 789] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:39 +0100] [Client 789] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:39 +0100] [Client 789] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] [Client 789] POST / HTTP/1.1
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 789] Read: status=200, state=6
D [13/Nov/2023:15:53:39 +0100] [Client 789] No authentication data provided.
D [13/Nov/2023:15:53:39 +0100] [Client 789] 2.0 Get-Job-Attributes 1609
D [13/Nov/2023:15:53:39 +0100] Get-Job-Attributes ipp://localhost/jobs/194
D [13/Nov/2023:15:53:39 +0100] [Client 789] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/194) from localhost.
D [13/Nov/2023:15:53:39 +0100] [Client 789] Content-Length: 101
D [13/Nov/2023:15:53:39 +0100] [Client 789] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [13/Nov/2023:15:53:39 +0100] [Client 789] con->http=0x55933aabfce0
D [13/Nov/2023:15:53:39 +0100] [Client 789] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=101, response=0x55933aaa7020(IPP_STATE_DATA), pipe_pid=0, file=-1
D [13/Nov/2023:15:53:39 +0100] [Client 789] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [13/Nov/2023:15:53:39 +0100] [Client 789] bytes=0, http_state=0, data_remaining=101
D [13/Nov/2023:15:53:39 +0100] [Client 789] Flushing write buffer.
D [13/Nov/2023:15:53:39 +0100] [Client 789] New state is HTTP_STATE_WAITING
D [13/Nov/2023:15:53:39 +0100] [Client 789] Waiting for request.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 789] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 789] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:39 +0100] [Client 780] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [13/Nov/2023:15:53:39 +0100] [Client 780] Closing connection.
D [13/Nov/2023:15:53:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:40 +0100] [Job 194] Page = 612x792; 18,36 to 594,756
D [13/Nov/2023:15:53:40 +0100] [Job 194] slow_collate=0, slow_duplex=0, slow_order=0
D [13/Nov/2023:15:53:40 +0100] [Job 194] Before copy_comments - %!PS-Adobe-3.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] %!PS-Adobe-3.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%Invocation: gs -q -dNOPAUSE -dBATCH -dSAFER -dNOMEDIAATTRS -sstdout=? -sDEVICE=ps2write -dShowAcroForm -sOUTPUTFILE=? -dLanguageLevel=3 -r600 -dCompressFonts=false -dNoT3CCITT -dNOINTERPOLATE ? ? -f ?
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%BoundingBox: 0 0 612 792
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%HiResBoundingBox: 0 0 612.00 792.00
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%Creator: GPL Ghostscript 9533 (ps2write)
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%LanguageLevel: 2
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%CreationDate: D:20231113155339+01\'00\'
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%Pages: 2
D [13/Nov/2023:15:53:40 +0100] [Job 194] %%EndComments
I [13/Nov/2023:15:53:40 +0100] Expiring subscriptions...
D [13/Nov/2023:15:53:40 +0100] [Job 194] Before copy_prolog - %%BeginProlog
D [13/Nov/2023:15:53:40 +0100] [Job 194] Filetype: PostScript
D [13/Nov/2023:15:53:40 +0100] [Job 194] Reading PostScript input ...
D [13/Nov/2023:15:53:40 +0100] [Job 194] --> This document is DSC-conforming!
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found %RBINumCopies: 1
D [13/Nov/2023:15:53:40 +0100] [Job 194] -----------
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%BeginProlog
D [13/Nov/2023:15:53:40 +0100] [Job 194] Inserting option code into \"Prolog\" section.
D [13/Nov/2023:15:53:40 +0100] [Job 194] Before copy_setup - %%Page: 1 1
D [13/Nov/2023:15:53:40 +0100] [Job 194] Before page loop - %%Page: 1 1
D [13/Nov/2023:15:53:40 +0100] [Job 194] Copying page 1...
D [13/Nov/2023:15:53:40 +0100] [Job 194] pagew = 576.0, pagel = 720.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [13/Nov/2023:15:53:40 +0100] [Job 194] PageLeft = 18.0, PageRight = 594.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] PageTop = 756.0, PageBottom = 36.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] PageWidth = 612.0, PageLength = 792.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%EndProlog
D [13/Nov/2023:15:53:40 +0100] [Job 194] -----------
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%BeginSetup
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%BeginFeature: *Resolution 600x600dpi
D [13/Nov/2023:15:53:40 +0100] [Job 194] Option: Resolution=600x600dpi
D [13/Nov/2023:15:53:40 +0100] [Job 194] --> Option will be set by PostScript interpreter
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%BeginFeature: *PageSize Letter
D [13/Nov/2023:15:53:40 +0100] [Job 194] Option: PageSize=Letter
D [13/Nov/2023:15:53:40 +0100] [Job 194] --> Option will be set by PostScript interpreter
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%BeginFeature: *InputSlot Default
D [13/Nov/2023:15:53:40 +0100] [Job 194] Option: InputSlot=Default
D [13/Nov/2023:15:53:40 +0100] [Job 194] --> Option will be set by PostScript interpreter
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%BeginFeature: *Duplex None
D [13/Nov/2023:15:53:40 +0100] [Job 194] Option: Duplex=None
D [13/Nov/2023:15:53:40 +0100] [Job 194] --> Option will be set by PostScript interpreter
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%EndSetup
D [13/Nov/2023:15:53:40 +0100] [Job 194] -----------
D [13/Nov/2023:15:53:40 +0100] [Job 194] New page: %%Page: 1 1
D [13/Nov/2023:15:53:40 +0100] [Job 194] \"Setup\" section is missing, inserting it.
D [13/Nov/2023:15:53:40 +0100] [Job 194] Inserting option code into \"Setup\" section.
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%BeginPageSetup
D [13/Nov/2023:15:53:40 +0100] [Job 194] Inserting option code into \"PageSetup\" section.
D [13/Nov/2023:15:53:40 +0100] [Job 194] Copying page 2...
D [13/Nov/2023:15:53:40 +0100] [Job 194] pagew = 576.0, pagel = 720.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [13/Nov/2023:15:53:40 +0100] [Job 194] PageLeft = 18.0, PageRight = 594.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] PageTop = 756.0, PageBottom = 36.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] PageWidth = 612.0, PageLength = 792.0
D [13/Nov/2023:15:53:40 +0100] [Job 194] Wrote 2 pages...
D [13/Nov/2023:15:53:40 +0100] [Job 194] New page found but previous not printed, print it now.
D [13/Nov/2023:15:53:40 +0100] [Job 194] Found: %%Page: 2 2
D [13/Nov/2023:15:53:40 +0100] [Job 194] --> Output goes directly to the renderer now.
D [13/Nov/2023:15:53:40 +0100] [Job 194] PID 16496 (pstops) exited with no errors.
D [13/Nov/2023:15:53:40 +0100] [Job 194] PID 16495 (gs) exited with no errors.
D [13/Nov/2023:15:53:40 +0100] [Job 194] Starting renderer with command: \"cat\"
D [13/Nov/2023:15:53:40 +0100] [Job 194] Starting process \"kid3\" (generation 1)
D [13/Nov/2023:15:53:40 +0100] [Job 194] Starting process \"kid4\" (generation 2)
D [13/Nov/2023:15:53:40 +0100] [Job 194] Starting process \"renderer\" (generation 2)
D [13/Nov/2023:15:53:40 +0100] [Job 194] JCL: \033%-12345X@PJL
D [13/Nov/2023:15:53:40 +0100] [Job 194] <job data>
D [13/Nov/2023:15:53:40 +0100] [Job 194] Read 8192 bytes of print data...
D [13/Nov/2023:15:53:40 +0100] [Job 194] Wrote 8192 bytes of print data...
D [13/Nov/2023:15:53:40 +0100] [Job 194] Read 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Wrote 8192 bytes of print data...
I [13/Nov/2023:15:53:41 +0100] Expiring subscriptions...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Read 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Wrote 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Read 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Wrote 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Read 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] kid4 exited with status 0
D [13/Nov/2023:15:53:41 +0100] [Job 194] kid3 finished
D [13/Nov/2023:15:53:41 +0100] [Job 194] Wrote 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Wrote 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Read 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] kid3 exited with status 0
D [13/Nov/2023:15:53:41 +0100] [Job 194] Wrote 8192 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Read 2370 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Wrote 2370 bytes of print data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] pdf-to-ps exited with status 0
D [13/Nov/2023:15:53:41 +0100] [Job 194] Closing foomatic-rip.
D [13/Nov/2023:15:53:41 +0100] [Job 194] Read 136 bytes of back-channel data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Sent 5015874 bytes...
D [13/Nov/2023:15:53:41 +0100] [Job 194] Waiting for read thread to exit...
D [13/Nov/2023:15:53:41 +0100] [Job 194] PID 16484 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
D [13/Nov/2023:15:53:41 +0100] [Job 194] Read 55 bytes of back-channel data...
D [13/Nov/2023:15:53:41 +0100] [Job 194] PID 16485 (/usr/lib/cups/backend/usb) exited with no errors.
D [13/Nov/2023:15:53:41 +0100] [Job 194] time-at-completed=1699887221
D [13/Nov/2023:15:53:41 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:41 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [13/Nov/2023:15:53:41 +0100] [Job 194] Job completed.
I [13/Nov/2023:15:53:41 +0100] Expiring subscriptions...
D [13/Nov/2023:15:53:41 +0100] cupsdMarkDirty(---J-)
D [13/Nov/2023:15:53:41 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:41 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:41 +0100] cupsdMarkDirty(----S)
D [13/Nov/2023:15:53:41 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:41 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:41 +0100] [Notifier] JobCompleted
D [13/Nov/2023:15:53:41 +0100] [Notifier] state=3
D [13/Nov/2023:15:53:41 +0100] [Notifier] PrinterStateChanged
D [13/Nov/2023:15:53:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [13/Nov/2023:15:53:42 +0100] [Client 790] Server address is "/run/cups/cups.sock".
D [13/Nov/2023:15:53:42 +0100] [Client 790] Accepted from localhost (Domain)
D [13/Nov/2023:15:53:42 +0100] [Client 790] Waiting for request.
I [13/Nov/2023:15:53:42 +0100] Expiring subscriptions...
D [13/Nov/2023:15:53:42 +0100] [Job 194] Unloading...
LinuxQuestions.org is looking for people interested in writing
Editorials, Articles, Reviews, and more. If you'd like to contribute
content, let us know.
