[cups] broken pipe but job successfull

Thu Aug 20 00:28:28 PDT 2020

> My first suspicion is that the print file causes the printer’s PS
> interpreter to crash and restart.
> Please send me the input file off the list (as the list deletes all
> attachments but text files).
>

Sample sent.

If can matter I'm attaching a sample of a printed document. There's still a
Broken pipe error, but it seems related to a side activity (?).

 D [20/Aug/2020:09:05:02 +0200] [Client 305] HTTP_STATE_WAITING Closing for
error 32 (Broken pipe)
-------------- next part --------------
I [20/Aug/2020:09:05:02 +0200] [Job 36679] Adding start banner page "none".
D [20/Aug/2020:09:05:02 +0200] Discarding unused job-created event...
I [20/Aug/2020:09:05:02 +0200] [Job 36679] Queued on "OLIVETTI_d-Copia_3500MF" by "root".
D [20/Aug/2020:09:05:02 +0200] [Client 305] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/OLIVETTI_d-Copia_3500MF) from localhost
D [20/Aug/2020:09:05:02 +0200] [Client 305] Content-Length: 203
D [20/Aug/2020:09:05:02 +0200] [Client 305] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [20/Aug/2020:09:05:02 +0200] [Client 305] con->http=0x564e3f6aae90
D [20/Aug/2020:09:05:02 +0200] [Client 305] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=203, response=0x564e3f684b80(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [20/Aug/2020:09:05:02 +0200] [Client 305] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [20/Aug/2020:09:05:02 +0200] [Client 305] bytes=0, http_state=0, data_remaining=203
D [20/Aug/2020:09:05:02 +0200] [Client 305] Flushing write buffer.
D [20/Aug/2020:09:05:02 +0200] [Client 305] New state is HTTP_STATE_WAITING
D [20/Aug/2020:09:05:02 +0200] [Client 305] Waiting for request.
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Client 305] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [20/Aug/2020:09:05:02 +0200] [Client 305] Closing connection.
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Client 306] Accepted from localhost (Domain)
D [20/Aug/2020:09:05:02 +0200] [Client 306] Waiting for request.
D [20/Aug/2020:09:05:02 +0200] [Client 306] POST /printers/OLIVETTI_d-Copia_3500MF HTTP/1.1
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=200
D [20/Aug/2020:09:05:02 +0200] [Client 306] No authentication data provided.
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] 2.0 Send-Document 3
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] [Client 306] Read: status=100
D [20/Aug/2020:09:05:02 +0200] Send-Document ipp://localhost:631/printers/OLIVETTI_d-Copia_3500MF
D [20/Aug/2020:09:05:02 +0200] cupsdIsAuthorized: requesting-user-name="root"
D [20/Aug/2020:09:05:02 +0200] [Job 36679] Auto-typing file...
D [20/Aug/2020:09:05:02 +0200] [Job 36679] Request file type is application/pdf.
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
I [20/Aug/2020:09:05:02 +0200] [Job 36679] File of type application/pdf queued by "root".
I [20/Aug/2020:09:05:02 +0200] [Job 36679] Adding end banner page "none".
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Client 306] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/OLIVETTI_d-Copia_3500MF) from localhost
D [20/Aug/2020:09:05:02 +0200] [Client 306] Content-Length: 173
D [20/Aug/2020:09:05:02 +0200] [Client 306] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [20/Aug/2020:09:05:02 +0200] [Client 306] con->http=0x564e3f6aae90
D [20/Aug/2020:09:05:02 +0200] [Client 306] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=173, response=0x564e3f6b00b0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [20/Aug/2020:09:05:02 +0200] [Client 306] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [20/Aug/2020:09:05:02 +0200] [Client 306] bytes=0, http_state=0, data_remaining=173
D [20/Aug/2020:09:05:02 +0200] [Client 306] Flushing write buffer.
D [20/Aug/2020:09:05:02 +0200] [Client 306] New state is HTTP_STATE_WAITING
D [20/Aug/2020:09:05:02 +0200] [Client 306] Waiting for request.
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Client 306] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [20/Aug/2020:09:05:02 +0200] [Client 306] Closing connection.
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Job 36676] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Job 36676] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:02 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] new_state=0, change_state=0
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Read 1085 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Wrote 1085 bytes of print data...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] STATE: +cups-waiting-for-job-completed
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [20/Aug/2020:09:05:02 +0200] [Job 36676] In attesa che la stampante finisca.
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Job 36676] Set job-printer-state-message to "In attesa che la stampante finisca.", current level=INFO
D [20/Aug/2020:09:05:02 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:02 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Job 36676] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:02 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:02 +0200] [Job 36676] new_state=0, change_state=0
D [20/Aug/2020:09:05:02 +0200] [Job 36676] PID 31156 (/usr/lib/cups/backend/socket) exited with no errors.
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Job 36676] time-at-completed=1597907102
D [20/Aug/2020:09:05:02 +0200] Discarding unused job-completed event...
I [20/Aug/2020:09:05:02 +0200] [Job 36676] Job completed.
I [20/Aug/2020:09:05:02 +0200] Expiring subscriptions...
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] time-at-processing=1597907102
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:02 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:02 +0200] [Job 36677] 3 filters for job:
D [20/Aug/2020:09:05:02 +0200] [Job 36677] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [20/Aug/2020:09:05:02 +0200] [Job 36677] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [20/Aug/2020:09:05:02 +0200] [Job 36677] - (application/vnd.cups-postscript to printer/OLIVETTI_d-Copia_3500MF, cost 0)
D [20/Aug/2020:09:05:02 +0200] [Job 36677] job-sheets=none,none
D [20/Aug/2020:09:05:02 +0200] [Job 36677] argv[0]="OLIVETTI_d-Copia_3500MF"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] argv[1]="36677"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] argv[2]="root"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] argv[3]="340213_ORDINE.pdf"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] argv[4]="1"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:7566f3d1-53cc-352e-648e-4efed9d683cd job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1597907101 time-at-processing=1597907102 document-name-supplied=340213_ORDINE.pdf"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] argv[6]="/var/spool/cups/d36677-001"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[8]="HOME=/var/spool/cups/tmp"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[10]="SERVER_ADMIN=root at yoweb"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[11]="SOFTWARE=CUPS/2.1.3"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[13]="USER=root"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[14]="CUPS_MAX_MESSAGE=2047"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[17]="IPP_PORT=631"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[18]="CHARSET=utf-8"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[19]="LANG=it_IT.UTF-8"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[20]="PPD=/etc/cups/ppd/OLIVETTI_d-Copia_3500MF.ppd"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[21]="RIP_MAX_CACHE=128m"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[22]="CONTENT_TYPE=application/pdf"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[23]="DEVICE_URI=socket://192.168.11.185"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[24]="PRINTER_INFO=KONICA MINOLTA C352/C300 PS(P)"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[25]="PRINTER_LOCATION="
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[26]="PRINTER=OLIVETTI_d-Copia_3500MF"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[27]="PRINTER_STATE_REASONS=developer-low-report,opc-near-eol-report"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[28]="CUPS_FILETYPE=document"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] envp[30]="AUTH_I****"
I [20/Aug/2020:09:05:02 +0200] [Job 36677] Started filter /usr/lib/cups/filter/pdftopdf (PID 31358)
I [20/Aug/2020:09:05:02 +0200] [Job 36677] Started filter /usr/lib/cups/filter/pdftops (PID 31359)
I [20/Aug/2020:09:05:02 +0200] [Job 36677] Started backend /usr/lib/cups/backend/socket (PID 31360)
D [20/Aug/2020:09:05:02 +0200] Discarding unused job-state-changed event...
D [20/Aug/2020:09:05:02 +0200] [Job 36677] pdftops - copying to temp print file \"/tmp/07a7f5f4c84cc\"
D [20/Aug/2020:09:05:02 +0200] [Job 36677] STATE: +connecting-to-device
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:02 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Looking up \"192.168.11.185\"...
D [20/Aug/2020:09:05:02 +0200] [Job 36677] PID 31358 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Printer make and model: KONICA MINOLTA C352/C300
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Switching to Poppler\'s pdftops instead of Ghostscript for Brother, Minolta, Konica Minolta, and Apple LaserWriter 12/640 to work around bugs in the printer\'s PS interpreters
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Running command line for pstops: pstops 36677 root 340213_ORDINE.pdf 1 \'finishings=3 job-uuid=urn:uuid:7566f3d1-53cc-352e-648e-4efed9d683cd job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1597907101 time-at-processing=1597907102 document-name-supplied=340213_ORDINE.pdf\'
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Using image rendering resolution 600 dpi
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Running command line for pdftops: pdftops -level3 -origpagesizes -nocenter -r 600 /tmp/07a7f5f4c84cc -
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Started filter pdftops (PID 31361)
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Started filter pstops (PID 31362)
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Page = 595x842; 12,12 to 583,830
D [20/Aug/2020:09:05:02 +0200] [Job 36677] slow_collate=0, slow_duplex=0, slow_order=0
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Before copy_comments - %!PS-Adobe-3.0
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %!PS-Adobe-3.0
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %Produced by poppler pdftops version: 0.41.0 (http://poppler.freedesktop.org)
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %%Creator: TCPDF
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %%LanguageLevel: 3
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %%DocumentSuppliedResources: (atend)
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %%DocumentMedia: A4 595 842 0 () ()
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %%BoundingBox: 0 0 596 842
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %%Pages: 1
D [20/Aug/2020:09:05:02 +0200] [Job 36677] %%EndComments
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Before copy_prolog - %%BeginProlog
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Before copy_setup - %%BeginSetup
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Before page loop - %%Page: 1 1
D [20/Aug/2020:09:05:02 +0200] [Job 36677] Copying page 1...
D [20/Aug/2020:09:05:02 +0200] [Job 36677] PAGE: 1 1
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:02 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:02 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:02 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:02 +0200] [Job 36677] pagew = 571.0, pagel = 818.0
D [20/Aug/2020:09:05:02 +0200] [Job 36677] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [20/Aug/2020:09:05:02 +0200] [Job 36677] PageLeft = 12.0, PageRight = 583.0
D [20/Aug/2020:09:05:02 +0200] [Job 36677] PageTop = 830.0, PageBottom = 12.0
D [20/Aug/2020:09:05:02 +0200] [Job 36677] PageWidth = 595.0, PageLength = 842.0
D [20/Aug/2020:09:05:03 +0200] [Job 36676] Unloading...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] ATTR: marker-colors=#00FFFF,#FF00FF,#FFFF00,#000000,#00FFFF,#00FFFF,#FF00FF,#FF00FF,#FFFF00,#FFFF00,#000000,#000000,none,none,none,none,none,none,none
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] ATTR: marker-names=\'\"Toner (Cyan)\"\',\'\"Toner (Magenta)\"\',\'\"Toner (Yellow)\"\',\'\"Toner (Black)\"\',\'\"Drum Cartridge (Cyan)\"\',\'\"Developer Cartridge (Cyan)\"\',\'\"Drum Cartridge (Magenta)\"\',\'\"Developer Cartridge (Magenta)\"\',\'\"Drum Cartridge (Yellow)\"\',\'\"Developer Cartridge (Yellow)\"\',\'\"Drum Cartridge (Black)\"\',\'\"Developer Cartridge (Black)\"\',\'\"Waste Toner Box\"\',\'\"Fusing Unit\"\',\'\"Image Transfer Belt Unit\"\',\'\"Transfer Roller Unit\"\',\'\"Staple Cartridge\"\',\'\"Saddle Staple Cartridge1\"\',\'\"Saddle Staple Cartridge2\"\'
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] ATTR: marker-types=toner,toner,toner,toner,opc,developer,opc,developer,opc,developer,opc,developer,waste-toner,fuser,transfer-unit,transfer-unit,staples,staples,staples
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] ATTR: marker-levels=81,82,83,94,93,99,93,99,95,99,44,2,-1,71,3,37,-1,-1,-1
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] new_supply_state=11, change_state=ffff
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: +developer-low-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -developer-empty-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -marker-supply-low-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -marker-supply-empty-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: +opc-near-eol-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -opc-life-over-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -toner-low-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -toner-empty-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -waste-receptacle-almost-full-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -waste-receptacle-full-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -cleaner-life-almost-over-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -cleaner-life-over-warning
D [20/Aug/2020:09:05:03 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] new_state=0, change_state=ffff
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -media-empty-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -door-open-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -media-jam-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -input-tray-missing-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -output-tray-missing-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -marker-supply-missing-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -output-area-almost-full-report
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -output-area-full-warning
D [20/Aug/2020:09:05:03 +0200] [Job 36677] backendWaitLoop(snmp_fd=6, addr=0x55d005e646d8, side_cb=0x55d005c03000)
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Connecting to 192.168.11.185:9100
I [20/Aug/2020:09:05:03 +0200] [Job 36677] Connessione alla stampante in corso.
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Set job-printer-state-message to "Connessione alla stampante in corso.", current level=INFO
D [20/Aug/2020:09:05:03 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:03 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: -connecting-to-device
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
I [20/Aug/2020:09:05:03 +0200] [Job 36677] Connesso alla stampante.
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Set job-printer-state-message to "Connesso alla stampante.", current level=INFO
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Connected to 192.168.11.185:9100...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] backendRunLoop(print_fd=0, device_fd=7, snmp_fd=6, addr=0x55d005e646d8, use_bc=1, side_cb=0x55d005c03000)
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:03 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] PID 31361 (pdftops) exited with no errors.
D [20/Aug/2020:09:05:03 +0200] [Job 36677] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:03 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] new_state=0, change_state=0
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 1 pages...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] PID 31362 (pstops) exited with no errors.
D [20/Aug/2020:09:05:03 +0200] [Job 36677] PID 31359 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Read 3975 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Wrote 3975 bytes of print data...
D [20/Aug/2020:09:05:03 +0200] [Job 36677] STATE: +cups-waiting-for-job-completed
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [20/Aug/2020:09:05:03 +0200] [Job 36677] In attesa che la stampante finisca.
D [20/Aug/2020:09:05:03 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:03 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:03 +0200] [Job 36677] Set job-printer-state-message to "In attesa che la stampante finisca.", current level=INFO
D [20/Aug/2020:09:05:03 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:03 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36677] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] [Job 36677] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36677] new_state=0, change_state=0
D [20/Aug/2020:09:05:04 +0200] [Job 36677] PID 31360 (/usr/lib/cups/backend/socket) exited with no errors.
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] [Job 36677] time-at-completed=1597907104
D [20/Aug/2020:09:05:04 +0200] Discarding unused job-completed event...
I [20/Aug/2020:09:05:04 +0200] [Job 36677] Job completed.
I [20/Aug/2020:09:05:04 +0200] Expiring subscriptions...
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] time-at-processing=1597907104
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] 3 filters for job:
D [20/Aug/2020:09:05:04 +0200] [Job 36678] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] - (application/vnd.cups-postscript to printer/OLIVETTI_d-Copia_3500MF, cost 0)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] job-sheets=none,none
D [20/Aug/2020:09:05:04 +0200] [Job 36678] argv[0]="OLIVETTI_d-Copia_3500MF"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] argv[1]="36678"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] argv[2]="root"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] argv[3]="340214_ETICHETTA.pdf"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] argv[4]="1"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:59d152db-6402-3e6d-6a42-79fbe0c99ace job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1597907101 time-at-processing=1597907104 document-name-supplied=340214_ETICHETTA.pdf"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] argv[6]="/var/spool/cups/d36678-001"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[8]="HOME=/var/spool/cups/tmp"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[10]="SERVER_ADMIN=root at yoweb"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[11]="SOFTWARE=CUPS/2.1.3"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[13]="USER=root"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[14]="CUPS_MAX_MESSAGE=2047"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[17]="IPP_PORT=631"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[18]="CHARSET=utf-8"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[19]="LANG=it_IT.UTF-8"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[20]="PPD=/etc/cups/ppd/OLIVETTI_d-Copia_3500MF.ppd"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[21]="RIP_MAX_CACHE=128m"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[22]="CONTENT_TYPE=application/pdf"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[23]="DEVICE_URI=socket://192.168.11.185"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[24]="PRINTER_INFO=KONICA MINOLTA C352/C300 PS(P)"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[25]="PRINTER_LOCATION="
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[26]="PRINTER=OLIVETTI_d-Copia_3500MF"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[27]="PRINTER_STATE_REASONS=developer-low-report,opc-near-eol-report"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[28]="CUPS_FILETYPE=document"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] envp[30]="AUTH_I****"
I [20/Aug/2020:09:05:04 +0200] [Job 36678] Started filter /usr/lib/cups/filter/pdftopdf (PID 31373)
I [20/Aug/2020:09:05:04 +0200] [Job 36678] Started filter /usr/lib/cups/filter/pdftops (PID 31374)
I [20/Aug/2020:09:05:04 +0200] [Job 36678] Started backend /usr/lib/cups/backend/socket (PID 31375)
D [20/Aug/2020:09:05:04 +0200] Discarding unused job-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] pdftops - copying to temp print file \"/tmp/07a8e5f45c0d5\"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PID 31373 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Printer make and model: KONICA MINOLTA C352/C300
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Switching to Poppler\'s pdftops instead of Ghostscript for Brother, Minolta, Konica Minolta, and Apple LaserWriter 12/640 to work around bugs in the printer\'s PS interpreters
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Running command line for pstops: pstops 36678 root 340214_ETICHETTA.pdf 1 \'finishings=3 job-uuid=urn:uuid:59d152db-6402-3e6d-6a42-79fbe0c99ace job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1597907101 time-at-processing=1597907104 document-name-supplied=340214_ETICHETTA.pdf\'
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Using image rendering resolution 600 dpi
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Running command line for pdftops: pdftops -level3 -origpagesizes -nocenter -r 600 /tmp/07a8e5f45c0d5 -
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Started filter pdftops (PID 31376)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Started filter pstops (PID 31377)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: +connecting-to-device
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Looking up \"192.168.11.185\"...
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PID 31376 (pdftops) exited with no errors.
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Page = 595x842; 12,12 to 583,830
D [20/Aug/2020:09:05:04 +0200] [Job 36678] slow_collate=0, slow_duplex=0, slow_order=0
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Before copy_comments - %!PS-Adobe-3.0
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %!PS-Adobe-3.0
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %Produced by poppler pdftops version: 0.41.0 (http://poppler.freedesktop.org)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %%Creator: TCPDF
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %%LanguageLevel: 3
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %%DocumentSuppliedResources: (atend)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %%DocumentMedia: A4 595 842 0 () ()
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %%BoundingBox: 0 0 596 842
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %%Pages: 1
D [20/Aug/2020:09:05:04 +0200] [Job 36678] %%EndComments
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Before copy_prolog - %%BeginProlog
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Before copy_setup - %%BeginSetup
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Before page loop - %%Page: 1 1
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Copying page 1...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PAGE: 1 1
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] pagew = 571.0, pagel = 818.0
D [20/Aug/2020:09:05:04 +0200] [Job 36678] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PageLeft = 12.0, PageRight = 583.0
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PageTop = 830.0, PageBottom = 12.0
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PageWidth = 595.0, PageLength = 842.0
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Wrote 1 pages...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PID 31377 (pstops) exited with no errors.
D [20/Aug/2020:09:05:04 +0200] [Job 36678] PID 31374 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [20/Aug/2020:09:05:04 +0200] [Job 36678] ATTR: marker-colors=#00FFFF,#FF00FF,#FFFF00,#000000,#00FFFF,#00FFFF,#FF00FF,#FF00FF,#FFFF00,#FFFF00,#000000,#000000,none,none,none,none,none,none,none
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] ATTR: marker-names=\'\"Toner (Cyan)\"\',\'\"Toner (Magenta)\"\',\'\"Toner (Yellow)\"\',\'\"Toner (Black)\"\',\'\"Drum Cartridge (Cyan)\"\',\'\"Developer Cartridge (Cyan)\"\',\'\"Drum Cartridge (Magenta)\"\',\'\"Developer Cartridge (Magenta)\"\',\'\"Drum Cartridge (Yellow)\"\',\'\"Developer Cartridge (Yellow)\"\',\'\"Drum Cartridge (Black)\"\',\'\"Developer Cartridge (Black)\"\',\'\"Waste Toner Box\"\',\'\"Fusing Unit\"\',\'\"Image Transfer Belt Unit\"\',\'\"Transfer Roller Unit\"\',\'\"Staple Cartridge\"\',\'\"Saddle Staple Cartridge1\"\',\'\"Saddle Staple Cartridge2\"\'
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] ATTR: marker-types=toner,toner,toner,toner,opc,developer,opc,developer,opc,developer,opc,developer,waste-toner,fuser,transfer-unit,transfer-unit,staples,staples,staples
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] ATTR: marker-levels=81,82,83,94,93,99,93,99,95,99,44,2,-1,71,3,37,-1,-1,-1
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] new_supply_state=11, change_state=ffff
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: +developer-low-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -developer-empty-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -marker-supply-low-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -marker-supply-empty-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: +opc-near-eol-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -opc-life-over-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -toner-low-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -toner-empty-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -waste-receptacle-almost-full-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -waste-receptacle-full-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -cleaner-life-almost-over-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -cleaner-life-over-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] new_state=0, change_state=ffff
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -media-empty-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -door-open-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -media-jam-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -input-tray-missing-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -output-tray-missing-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -marker-supply-missing-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -output-area-almost-full-report
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -output-area-full-warning
D [20/Aug/2020:09:05:04 +0200] [Job 36678] backendWaitLoop(snmp_fd=6, addr=0x555d517db6d8, side_cb=0x555d50e16000)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Connecting to 192.168.11.185:9100
I [20/Aug/2020:09:05:04 +0200] [Job 36678] Connessione alla stampante in corso.
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Set job-printer-state-message to "Connessione alla stampante in corso.", current level=INFO
D [20/Aug/2020:09:05:04 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] STATE: -connecting-to-device
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
I [20/Aug/2020:09:05:04 +0200] [Job 36678] Connesso alla stampante.
D [20/Aug/2020:09:05:04 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:04 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Set job-printer-state-message to "Connesso alla stampante.", current level=INFO
D [20/Aug/2020:09:05:04 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:04 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Connected to 192.168.11.185:9100...
D [20/Aug/2020:09:05:04 +0200] [Job 36678] backendRunLoop(print_fd=0, device_fd=7, snmp_fd=6, addr=0x555d517db6d8, use_bc=1, side_cb=0x555d50e16000)
D [20/Aug/2020:09:05:04 +0200] [Job 36678] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36677] Unloading...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:05 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:05 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:05 +0200] [Job 36678] new_state=0, change_state=0
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Read 1702 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Wrote 1702 bytes of print data...
D [20/Aug/2020:09:05:05 +0200] [Job 36678] STATE: +cups-waiting-for-job-completed
D [20/Aug/2020:09:05:05 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:05 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:05 +0200] Discarding unused printer-state-changed event...
I [20/Aug/2020:09:05:05 +0200] [Job 36678] In attesa che la stampante finisca.
D [20/Aug/2020:09:05:05 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:05 +0200] [Job 36678] Set job-printer-state-message to "In attesa che la stampante finisca.", current level=INFO
D [20/Aug/2020:09:05:05 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:05 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36678] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36678] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36678] new_state=0, change_state=0
D [20/Aug/2020:09:05:06 +0200] [Job 36678] PID 31375 (/usr/lib/cups/backend/socket) exited with no errors.
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36678] time-at-completed=1597907106
D [20/Aug/2020:09:05:06 +0200] Discarding unused job-completed event...
I [20/Aug/2020:09:05:06 +0200] [Job 36678] Job completed.
I [20/Aug/2020:09:05:06 +0200] Expiring subscriptions...
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] time-at-processing=1597907106
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] 3 filters for job:
D [20/Aug/2020:09:05:06 +0200] [Job 36679] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] pdftops (application/vnd.cups-pdf to application/vnd.cups-postscript, cost 100)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] - (application/vnd.cups-postscript to printer/OLIVETTI_d-Copia_3500MF, cost 0)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] job-sheets=none,none
D [20/Aug/2020:09:05:06 +0200] [Job 36679] argv[0]="OLIVETTI_d-Copia_3500MF"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] argv[1]="36679"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] argv[2]="root"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] argv[3]="340214_ORDINE.pdf"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] argv[4]="1"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] argv[5]="finishings=3 number-up=1 job-uuid=urn:uuid:87981734-8eb2-3a1b-5e47-7f654aafb4d2 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1597907102 time-at-processing=1597907106 document-name-supplied=340214_ORDINE.pdf"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] argv[6]="/var/spool/cups/d36679-001"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[8]="HOME=/var/spool/cups/tmp"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[10]="SERVER_ADMIN=root at yoweb"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[11]="SOFTWARE=CUPS/2.1.3"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[13]="USER=root"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[14]="CUPS_MAX_MESSAGE=2047"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[17]="IPP_PORT=631"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[18]="CHARSET=utf-8"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[19]="LANG=it_IT.UTF-8"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[20]="PPD=/etc/cups/ppd/OLIVETTI_d-Copia_3500MF.ppd"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[21]="RIP_MAX_CACHE=128m"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[22]="CONTENT_TYPE=application/pdf"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[23]="DEVICE_URI=socket://192.168.11.185"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[24]="PRINTER_INFO=KONICA MINOLTA C352/C300 PS(P)"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[25]="PRINTER_LOCATION="
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[26]="PRINTER=OLIVETTI_d-Copia_3500MF"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[27]="PRINTER_STATE_REASONS=developer-low-report,opc-near-eol-report"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[28]="CUPS_FILETYPE=document"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] envp[30]="AUTH_I****"
I [20/Aug/2020:09:05:06 +0200] [Job 36679] Started filter /usr/lib/cups/filter/pdftopdf (PID 31384)
I [20/Aug/2020:09:05:06 +0200] [Job 36679] Started filter /usr/lib/cups/filter/pdftops (PID 31385)
I [20/Aug/2020:09:05:06 +0200] [Job 36679] Started backend /usr/lib/cups/backend/socket (PID 31386)
D [20/Aug/2020:09:05:06 +0200] Discarding unused job-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] pdftops - copying to temp print file \"/tmp/07a995f4189e3\"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: +connecting-to-device
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Looking up \"192.168.11.185\"...
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PID 31384 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Printer make and model: KONICA MINOLTA C352/C300
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Switching to Poppler\'s pdftops instead of Ghostscript for Brother, Minolta, Konica Minolta, and Apple LaserWriter 12/640 to work around bugs in the printer\'s PS interpreters
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Running command line for pstops: pstops 36679 root 340214_ORDINE.pdf 1 \'finishings=3 job-uuid=urn:uuid:87981734-8eb2-3a1b-5e47-7f654aafb4d2 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1597907102 time-at-processing=1597907106 document-name-supplied=340214_ORDINE.pdf\'
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Using image rendering resolution 600 dpi
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Running command line for pdftops: pdftops -level3 -origpagesizes -nocenter -r 600 /tmp/07a995f4189e3 -
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Started filter pdftops (PID 31387)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Started filter pstops (PID 31388)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Page = 595x842; 12,12 to 583,830
D [20/Aug/2020:09:05:06 +0200] [Job 36679] slow_collate=0, slow_duplex=0, slow_order=0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Before copy_comments - %!PS-Adobe-3.0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %!PS-Adobe-3.0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %Produced by poppler pdftops version: 0.41.0 (http://poppler.freedesktop.org)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %%Creator: TCPDF
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %%LanguageLevel: 3
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %%DocumentSuppliedResources: (atend)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %%DocumentMedia: A4 595 842 0 () ()
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %%BoundingBox: 0 0 596 842
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %%Pages: 1
D [20/Aug/2020:09:05:06 +0200] [Job 36679] %%EndComments
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Before copy_prolog - %%BeginProlog
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Before copy_setup - %%BeginSetup
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Before page loop - %%Page: 1 1
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Copying page 1...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PAGE: 1 1
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] pagew = 571.0, pagel = 818.0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PageLeft = 12.0, PageRight = 583.0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PageTop = 830.0, PageBottom = 12.0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PageWidth = 595.0, PageLength = 842.0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] ATTR: marker-colors=#00FFFF,#FF00FF,#FFFF00,#000000,#00FFFF,#00FFFF,#FF00FF,#FF00FF,#FFFF00,#FFFF00,#000000,#000000,none,none,none,none,none,none,none
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] ATTR: marker-names=\'\"Toner (Cyan)\"\',\'\"Toner (Magenta)\"\',\'\"Toner (Yellow)\"\',\'\"Toner (Black)\"\',\'\"Drum Cartridge (Cyan)\"\',\'\"Developer Cartridge (Cyan)\"\',\'\"Drum Cartridge (Magenta)\"\',\'\"Developer Cartridge (Magenta)\"\',\'\"Drum Cartridge (Yellow)\"\',\'\"Developer Cartridge (Yellow)\"\',\'\"Drum Cartridge (Black)\"\',\'\"Developer Cartridge (Black)\"\',\'\"Waste Toner Box\"\',\'\"Fusing Unit\"\',\'\"Image Transfer Belt Unit\"\',\'\"Transfer Roller Unit\"\',\'\"Staple Cartridge\"\',\'\"Saddle Staple Cartridge1\"\',\'\"Saddle Staple Cartridge2\"\'
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] ATTR: marker-types=toner,toner,toner,toner,opc,developer,opc,developer,opc,developer,opc,developer,waste-toner,fuser,transfer-unit,transfer-unit,staples,staples,staples
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] ATTR: marker-levels=81,82,83,94,93,99,93,99,95,99,44,2,-1,71,3,37,-1,-1,-1
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] new_supply_state=11, change_state=ffff
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: +developer-low-report
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -developer-empty-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -marker-supply-low-report
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -marker-supply-empty-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: +opc-near-eol-report
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -opc-life-over-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -toner-low-report
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -toner-empty-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -waste-receptacle-almost-full-report
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -waste-receptacle-full-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -cleaner-life-almost-over-report
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -cleaner-life-over-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] new_state=0, change_state=ffff
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -media-empty-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -door-open-report
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -media-jam-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -input-tray-missing-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -output-tray-missing-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -marker-supply-missing-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -output-area-almost-full-report
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -output-area-full-warning
D [20/Aug/2020:09:05:06 +0200] [Job 36679] backendWaitLoop(snmp_fd=6, addr=0x560fc386b6d8, side_cb=0x560fc28b6000)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Connecting to 192.168.11.185:9100
I [20/Aug/2020:09:05:06 +0200] [Job 36679] Connessione alla stampante in corso.
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Set job-printer-state-message to "Connessione alla stampante in corso.", current level=INFO
D [20/Aug/2020:09:05:06 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: -connecting-to-device
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
I [20/Aug/2020:09:05:06 +0200] [Job 36679] Connesso alla stampante.
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Set job-printer-state-message to "Connesso alla stampante.", current level=INFO
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Connected to 192.168.11.185:9100...
D [20/Aug/2020:09:05:06 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] backendRunLoop(print_fd=0, device_fd=7, snmp_fd=6, addr=0x560fc386b6d8, use_bc=1, side_cb=0x560fc28b6000)
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PID 31387 (pdftops) exited with no errors.
D [20/Aug/2020:09:05:06 +0200] [Job 36679] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] new_state=0, change_state=0
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 1 pages...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PID 31388 (pstops) exited with no errors.
D [20/Aug/2020:09:05:06 +0200] [Job 36679] PID 31385 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 8192 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Read 732 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Wrote 732 bytes of print data...
D [20/Aug/2020:09:05:06 +0200] [Job 36679] STATE: +cups-waiting-for-job-completed
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [20/Aug/2020:09:05:06 +0200] [Job 36679] In attesa che la stampante finisca.
D [20/Aug/2020:09:05:06 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:06 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:06 +0200] [Job 36679] Set job-printer-state-message to "In attesa che la stampante finisca.", current level=INFO
D [20/Aug/2020:09:05:06 +0200] Discarding unused job-progress event...
D [20/Aug/2020:09:05:06 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:07 +0200] [Job 36678] Unloading...
D [20/Aug/2020:09:05:07 +0200] [Job 36679] ATTR: marker-levels=81,82,83,92,93,99,93,99,95,99,43,2,-1,71,3,36,-1,-1,-1
D [20/Aug/2020:09:05:07 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:07 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:07 +0200] [Job 36679] new_supply_state=11, change_state=0
D [20/Aug/2020:09:05:07 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:07 +0200] [Job 36679] new_state=0, change_state=0
D [20/Aug/2020:09:05:07 +0200] [Job 36679] PID 31386 (/usr/lib/cups/backend/socket) exited with no errors.
D [20/Aug/2020:09:05:07 +0200] cupsdMarkDirty(P----)
D [20/Aug/2020:09:05:07 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:07 +0200] [Job 36679] time-at-completed=1597907107
D [20/Aug/2020:09:05:07 +0200] Discarding unused job-completed event...
I [20/Aug/2020:09:05:07 +0200] [Job 36679] Job completed.
I [20/Aug/2020:09:05:07 +0200] Expiring subscriptions...
D [20/Aug/2020:09:05:07 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:07 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:07 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:07 +0200] Discarding unused printer-state-changed event...
D [20/Aug/2020:09:05:07 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:07 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:07 +0200] cupsdMarkDirty(---J-)
D [20/Aug/2020:09:05:07 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [20/Aug/2020:09:05:08 +0200] [Job 36679] Unloading...
I [20/Aug/2020:09:05:32 +0200] Saving printers.conf...
I [20/Aug/2020:09:05:32 +0200] Saving job.cache...
D [20/Aug/2020:09:05:32 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"