RasPi - MP550 - Cups "Filter Error"
Verfasst: So 05 Nov, 2017 15:47
Hallo zusammen,
mein Setup:
Raspberry Pi als Druckserver, daran ein Canon MP550 und ein HP LaserJet 1505n (der läuft ohne Probleme).
Als Clients habe ich zwei Macs, Drucken funktionierte Monatelang prima auf beiden Druckern.
Beide Drucker hatte ich ohne TurboPrint mit Gutenprint-Treibern als RAW-Drucker installiert,
auf dem Canon war die Druckqualität aber mehr als mies, daher will ich es für den MP550 mit den TurboPrint-Treibern versuchen.
Also den MP550 aus Cups rausgeschmissen, TurboPrint installiert, MP550 installiert, auch in CUPS, alles kein Problem.
Ich kann sowohl aus CUPS als auch aus dem CanonMP550-Druckermenü auf beiden Macs (!) eine Testseite drucken lassen (über die Tetseitenfunktion),
klappt ohne Probleme, sofort und gut.
Sobald ich eine echte Datei (Excel, Word, Webseite, Bild, wasauchimmer) drucken will bekomme ich
in CUPS ständig die Fehlermeldung "Filter Error" und der Druckjob wird nicht gedruckt.
Wer kann sich das mal anschauen? Nach 5 h suchen bin ich mit meinem Latein am Ende.
Danke!
Hier die Cups Error_Log:
D [05/Nov/2017:15:17:07 +0100] [Client 20] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:07 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] [Client 20] 2.0 Get-Printer-Attributes 7
D [05/Nov/2017:15:17:07 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 20] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 20] Content-Length: 1882
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1882, response=0x55766f10(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] Send-Document ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] cupsdIsAuthorized: requesting-user-name="wilko"
D [05/Nov/2017:15:17:07 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [05/Nov/2017:15:17:07 +0100] [Job 1231] File of type application/vnd.cups-raster queued by "wilko".
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Adding end banner page "none".
D [05/Nov/2017:15:17:07 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] time-at-processing=1509891427
D [05/Nov/2017:15:17:07 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] Discarding unused printer-state-changed event...
D [05/Nov/2017:15:17:07 +0100] [Job 1231] 5 filters for job:
D [05/Nov/2017:15:17:07 +0100] [Job 1231] rastertopwg (application/vnd.cups-raster to image/pwg-raster, cost 100)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] rastertopdf (image/pwg-raster to application/pdf, cost 32)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] pstoturboprint (application/vnd.cups-pdf to printer/Canon_MP550_series_TP/application/vnd.cups-raw, cost 10)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] - (printer/Canon_MP550_series_TP/application/vnd.cups-raw to printer/Canon_MP550_series_TP, cost 0)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] job-sheets=none,none
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[0]="Canon_MP550_series_TP"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[1]="1231"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[2]="wilko"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[3]="2017-10-30 Einnahmen und Ausgaben.xlsx"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[4]="1"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[5]="job-uuid=urn:uuid:b77d73a7-dddd-3731-6a08-f2f7a966760d job-originating-host-name=192.168.178.32 time-at-creation=1509891426 time-at-processing=1509891427"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[6]="/var/spool/cups/d01231-001"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[8]="HOME=/var/spool/cups/tmp"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[10]="SERVER_ADMIN=root@printpi"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[11]="SOFTWARE=CUPS/1.7.5"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[13]="USER=root"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[14]="CUPS_MAX_MESSAGE=2047"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[17]="IPP_PORT=631"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[18]="CHARSET=utf-8"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[19]="LANG=de_DE.UTF-8"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[20]="PPD=/etc/cups/ppd/Canon_MP550_series_TP.ppd"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[21]="RIP_MAX_CACHE=128m"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[22]="CONTENT_TYPE=application/vnd.cups-raster"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[23]="DEVICE_URI=tpu://Canon/MP550_series/SN=301335"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[24]="PRINTER_INFO=Canon MP550 series"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[25]="PRINTER_LOCATION=PrintPi"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[26]="PRINTER=Canon_MP550_series_TP"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[27]="PRINTER_STATE_REASONS=none"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[28]="CUPS_FILETYPE=document"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raw"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[30]="AUTH_I****"
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/rastertopwg (PID 1322)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/rastertopdf (PID 1323)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/pdftopdf (PID 1324)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/pstoturboprint (PID 1325)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started backend /usr/lib/cups/backend/tpu (PID 1326)
D [05/Nov/2017:15:17:07 +0100] Discarding unused job-state-changed event...
D [05/Nov/2017:15:17:07 +0100] [Client 18] Returning IPP successful-ok for Send-Document (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 18] Content-Length: 181
D [05/Nov/2017:15:17:07 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] [Client 20] 2.0 Get-Job-Attributes 8
D [05/Nov/2017:15:17:07 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 20] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 20] Content-Length: 264
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=181, response=0x55814bc8(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x558172a8(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] [Client 18] 2.0 Get-Printer-Attributes 9
D [05/Nov/2017:15:17:07 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 18] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 18] Content-Length: 1882
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1882, response=0x557fce48(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:07 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:07 +0100] [Client 18] Closing connection.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] 2.0 Get-Job-Attributes 10
D [05/Nov/2017:15:17:07 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 18] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 18] Content-Length: 264
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x55802a38(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Job 1231] PID 1322 (/usr/lib/cups/filter/rastertopwg) exited with no errors.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 118: /var/log/turboprint/print.log: No such file or directory
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Color Manager: Calibration Mode/Off
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Calling FindDeviceById(cups-Canon_MP550_series_TP)
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Found device /org/freedesktop/ColorManager/devices/cups_Canon_MP550_series_TP
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] PID 1323 (/usr/lib/cups/filter/rastertopdf) stopped with status 1.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] PID 1324 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] POST / HTTP/1.1
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:08 +0100] cupsdIsAuthorized: username=""
D [05/Nov/2017:15:17:08 +0100] [Client 20] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [05/Nov/2017:15:17:08 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 22] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 22] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:08 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 22] POST / HTTP/1.1
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] [Client 22] Authorized as lp using PeerCred
D [05/Nov/2017:15:17:08 +0100] cupsdIsAuthorized: username="lp"
D [05/Nov/2017:15:17:08 +0100] [Client 22] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] lpstat: Invalid destination name in list "Canon_MP550_series_TP".
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] POST /printers/ HTTP/1.1
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:08 +0100] [Client 20] 2.0 CUPS-Get-Printers 1
D [05/Nov/2017:15:17:08 +0100] CUPS-Get-Printers
D [05/Nov/2017:15:17:08 +0100] [Client 20] Returning IPP successful-ok for CUPS-Get-Printers () from localhost
D [05/Nov/2017:15:17:08 +0100] [Client 20] Content-Length: 946
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=946, response=0x557fce48(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:08 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:08 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:08 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:09 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] [Client 20] 2.0 Get-Printer-Attributes 11
D [05/Nov/2017:15:17:09 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 20] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 20] Content-Length: 1895
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1895, response=0x55802a88(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] 2.0 Get-Job-Attributes 12
D [05/Nov/2017:15:17:09 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 20] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 20] Content-Length: 264
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x55767288(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:09 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] 2.0 Get-Printer-Attributes 13
D [05/Nov/2017:15:17:09 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 18] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 18] Content-Length: 1895
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1895, response=0x55767288(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:09 +0100] [Client 18] Closing connection.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:09 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] [Client 18] 2.0 Get-Job-Attributes 14
D [05/Nov/2017:15:17:09 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 18] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 18] Content-Length: 264
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x557fabb0(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** Warning: Invalid Page count.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** Warning: Invalid Page count.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** This file had errors that were repaired or ignored.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** Please notify the author of the software that produced this
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** file that it does not conform to Adobe's published PDF
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** specification.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 60: kill: (1349) - No such process
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 63: kill: (1351) - No such process
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] 2.0 Get-Printer-Attributes 15
D [05/Nov/2017:15:17:10 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:10 +0100] [Client 18] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:10 +0100] [Client 18] Content-Length: 1895
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1895, response=0x557fd6a0(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:10 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:10 +0100] [Client 18] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:10 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:10 +0100] [Client 18] 2.0 Get-Job-Attributes 16
D [05/Nov/2017:15:17:10 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:10 +0100] [Client 18] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:10 +0100] [Client 18] Content-Length: 264
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x557fce48(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:10 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:10 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 20] POST /jobs/ HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:10 +0100] cupsdIsAuthorized: username=""
D [05/Nov/2017:15:17:10 +0100] [Client 20] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [05/Nov/2017:15:17:10 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:10 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 22] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:10 +0100] [Client 22] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:10 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 22] POST /jobs/ HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 22] Authorized as lp using PeerCred
D [05/Nov/2017:15:17:10 +0100] cupsdIsAuthorized: username="lp"
D [05/Nov/2017:15:17:10 +0100] [Client 22] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 80: kill: (1349) - No such process
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
I [05/Nov/2017:15:17:10 +0100] [Job 1231] Drucker ist bereit
D [05/Nov/2017:15:17:10 +0100] Discarding unused job-progress event...
D [05/Nov/2017:15:17:10 +0100] Discarding unused printer-state-changed event...
D [05/Nov/2017:15:17:10 +0100] [Job 1231] PID 1325 (/usr/lib/cups/filter/pstoturboprint) exited with no errors.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Job 1231] PID 1326 (/usr/lib/cups/backend/tpu) exited with no errors.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] Discarding unused job-state-changed event...
E [05/Nov/2017:15:17:11 +0100] [Job 1231] Job stopped due to filter errors; please consult the error_log file for details.
D [05/Nov/2017:15:17:11 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] Discarding unused printer-state-changed event...
D [05/Nov/2017:15:17:11 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:11 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:11 +0100] [Client 20] 2.0 Get-Printer-Attributes 17
D [05/Nov/2017:15:17:11 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:11 +0100] [Client 20] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:11 +0100] [Client 20] Content-Length: 1900
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1900, response=0x55767260(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:11 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:11 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:11 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [05/Nov/2017:15:17:11 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
mein Setup:
Raspberry Pi als Druckserver, daran ein Canon MP550 und ein HP LaserJet 1505n (der läuft ohne Probleme).
Als Clients habe ich zwei Macs, Drucken funktionierte Monatelang prima auf beiden Druckern.
Beide Drucker hatte ich ohne TurboPrint mit Gutenprint-Treibern als RAW-Drucker installiert,
auf dem Canon war die Druckqualität aber mehr als mies, daher will ich es für den MP550 mit den TurboPrint-Treibern versuchen.
Also den MP550 aus Cups rausgeschmissen, TurboPrint installiert, MP550 installiert, auch in CUPS, alles kein Problem.
Ich kann sowohl aus CUPS als auch aus dem CanonMP550-Druckermenü auf beiden Macs (!) eine Testseite drucken lassen (über die Tetseitenfunktion),
klappt ohne Probleme, sofort und gut.
Sobald ich eine echte Datei (Excel, Word, Webseite, Bild, wasauchimmer) drucken will bekomme ich
in CUPS ständig die Fehlermeldung "Filter Error" und der Druckjob wird nicht gedruckt.
Wer kann sich das mal anschauen? Nach 5 h suchen bin ich mit meinem Latein am Ende.
Danke!
Hier die Cups Error_Log:
D [05/Nov/2017:15:17:07 +0100] [Client 20] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:07 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] [Client 20] 2.0 Get-Printer-Attributes 7
D [05/Nov/2017:15:17:07 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 20] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 20] Content-Length: 1882
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1882, response=0x55766f10(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] Send-Document ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] cupsdIsAuthorized: requesting-user-name="wilko"
D [05/Nov/2017:15:17:07 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [05/Nov/2017:15:17:07 +0100] [Job 1231] File of type application/vnd.cups-raster queued by "wilko".
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Adding end banner page "none".
D [05/Nov/2017:15:17:07 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] time-at-processing=1509891427
D [05/Nov/2017:15:17:07 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] Discarding unused printer-state-changed event...
D [05/Nov/2017:15:17:07 +0100] [Job 1231] 5 filters for job:
D [05/Nov/2017:15:17:07 +0100] [Job 1231] rastertopwg (application/vnd.cups-raster to image/pwg-raster, cost 100)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] rastertopdf (image/pwg-raster to application/pdf, cost 32)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] pstoturboprint (application/vnd.cups-pdf to printer/Canon_MP550_series_TP/application/vnd.cups-raw, cost 10)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] - (printer/Canon_MP550_series_TP/application/vnd.cups-raw to printer/Canon_MP550_series_TP, cost 0)
D [05/Nov/2017:15:17:07 +0100] [Job 1231] job-sheets=none,none
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[0]="Canon_MP550_series_TP"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[1]="1231"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[2]="wilko"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[3]="2017-10-30 Einnahmen und Ausgaben.xlsx"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[4]="1"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[5]="job-uuid=urn:uuid:b77d73a7-dddd-3731-6a08-f2f7a966760d job-originating-host-name=192.168.178.32 time-at-creation=1509891426 time-at-processing=1509891427"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] argv[6]="/var/spool/cups/d01231-001"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[8]="HOME=/var/spool/cups/tmp"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[10]="SERVER_ADMIN=root@printpi"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[11]="SOFTWARE=CUPS/1.7.5"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[13]="USER=root"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[14]="CUPS_MAX_MESSAGE=2047"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[17]="IPP_PORT=631"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[18]="CHARSET=utf-8"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[19]="LANG=de_DE.UTF-8"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[20]="PPD=/etc/cups/ppd/Canon_MP550_series_TP.ppd"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[21]="RIP_MAX_CACHE=128m"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[22]="CONTENT_TYPE=application/vnd.cups-raster"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[23]="DEVICE_URI=tpu://Canon/MP550_series/SN=301335"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[24]="PRINTER_INFO=Canon MP550 series"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[25]="PRINTER_LOCATION=PrintPi"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[26]="PRINTER=Canon_MP550_series_TP"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[27]="PRINTER_STATE_REASONS=none"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[28]="CUPS_FILETYPE=document"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raw"
D [05/Nov/2017:15:17:07 +0100] [Job 1231] envp[30]="AUTH_I****"
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/rastertopwg (PID 1322)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/rastertopdf (PID 1323)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/pdftopdf (PID 1324)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started filter /usr/lib/cups/filter/pstoturboprint (PID 1325)
I [05/Nov/2017:15:17:07 +0100] [Job 1231] Started backend /usr/lib/cups/backend/tpu (PID 1326)
D [05/Nov/2017:15:17:07 +0100] Discarding unused job-state-changed event...
D [05/Nov/2017:15:17:07 +0100] [Client 18] Returning IPP successful-ok for Send-Document (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 18] Content-Length: 181
D [05/Nov/2017:15:17:07 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] [Client 20] 2.0 Get-Job-Attributes 8
D [05/Nov/2017:15:17:07 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 20] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 20] Content-Length: 264
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=181, response=0x55814bc8(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x558172a8(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] [Client 18] 2.0 Get-Printer-Attributes 9
D [05/Nov/2017:15:17:07 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 18] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 18] Content-Length: 1882
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1882, response=0x557fce48(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:07 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:07 +0100] [Client 18] Closing connection.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:07 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] 2.0 Get-Job-Attributes 10
D [05/Nov/2017:15:17:07 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:07 +0100] [Client 18] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:07 +0100] [Client 18] Content-Length: 264
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x55802a38(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:07 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:07 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:07 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:07 +0100] [Job 1231] PID 1322 (/usr/lib/cups/filter/rastertopwg) exited with no errors.
D [05/Nov/2017:15:17:07 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 118: /var/log/turboprint/print.log: No such file or directory
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Color Manager: Calibration Mode/Off
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Calling FindDeviceById(cups-Canon_MP550_series_TP)
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Found device /org/freedesktop/ColorManager/devices/cups_Canon_MP550_series_TP
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] PID 1323 (/usr/lib/cups/filter/rastertopdf) stopped with status 1.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] PID 1324 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] POST / HTTP/1.1
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:08 +0100] cupsdIsAuthorized: username=""
D [05/Nov/2017:15:17:08 +0100] [Client 20] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [05/Nov/2017:15:17:08 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 22] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 22] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:08 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 22] POST / HTTP/1.1
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] [Client 22] Authorized as lp using PeerCred
D [05/Nov/2017:15:17:08 +0100] cupsdIsAuthorized: username="lp"
D [05/Nov/2017:15:17:08 +0100] [Client 22] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Job 1231] lpstat: Invalid destination name in list "Canon_MP550_series_TP".
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] POST /printers/ HTTP/1.1
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:08 +0100] [Client 20] 2.0 CUPS-Get-Printers 1
D [05/Nov/2017:15:17:08 +0100] CUPS-Get-Printers
D [05/Nov/2017:15:17:08 +0100] [Client 20] Returning IPP successful-ok for CUPS-Get-Printers () from localhost
D [05/Nov/2017:15:17:08 +0100] [Client 20] Content-Length: 946
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=946, response=0x557fce48(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:08 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:08 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:08 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:08 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:08 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:08 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:08 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:09 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] [Client 20] 2.0 Get-Printer-Attributes 11
D [05/Nov/2017:15:17:09 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 20] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 20] Content-Length: 1895
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1895, response=0x55802a88(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] 2.0 Get-Job-Attributes 12
D [05/Nov/2017:15:17:09 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 20] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 20] Content-Length: 264
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x55767288(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:09 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] 2.0 Get-Printer-Attributes 13
D [05/Nov/2017:15:17:09 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 18] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 18] Content-Length: 1895
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1895, response=0x55767288(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:09 +0100] [Client 18] Closing connection.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:09 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:09 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:09 +0100] [Client 18] 2.0 Get-Job-Attributes 14
D [05/Nov/2017:15:17:09 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:09 +0100] [Client 18] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:09 +0100] [Client 18] Content-Length: 264
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x557fabb0(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:09 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:09 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:09 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** Warning: Invalid Page count.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** Warning: Invalid Page count.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** This file had errors that were repaired or ignored.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** Please notify the author of the software that produced this
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** file that it does not conform to Adobe's published PDF
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] **** specification.
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 60: kill: (1349) - No such process
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:09 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 63: kill: (1351) - No such process
D [05/Nov/2017:15:17:09 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] 2.0 Get-Printer-Attributes 15
D [05/Nov/2017:15:17:10 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:10 +0100] [Client 18] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:10 +0100] [Client 18] Content-Length: 1895
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1895, response=0x557fd6a0(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:10 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:10 +0100] [Client 18] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:10 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 18] No authentication data provided.
D [05/Nov/2017:15:17:10 +0100] [Client 18] 2.0 Get-Job-Attributes 16
D [05/Nov/2017:15:17:10 +0100] Get-Job-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:10 +0100] [Client 18] Returning IPP successful-ok for Get-Job-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:10 +0100] [Client 18] Content-Length: 264
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 18] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=264, response=0x557fce48(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:10 +0100] [Client 18] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:10 +0100] [Client 18] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:10 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 20] POST /jobs/ HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:10 +0100] cupsdIsAuthorized: username=""
D [05/Nov/2017:15:17:10 +0100] [Client 20] WWW-Authenticate: Basic realm="CUPS", trc="y"
D [05/Nov/2017:15:17:10 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 20] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:10 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 22] Accepted from localhost (Domain)
D [05/Nov/2017:15:17:10 +0100] [Client 22] Waiting for request.
D [05/Nov/2017:15:17:10 +0100] [Client 20] HTTP_STATE_WAITING Closing on EOF
D [05/Nov/2017:15:17:10 +0100] [Client 20] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Client 22] POST /jobs/ HTTP/1.1
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:10 +0100] [Client 22] Authorized as lp using PeerCred
D [05/Nov/2017:15:17:10 +0100] cupsdIsAuthorized: username="lp"
D [05/Nov/2017:15:17:10 +0100] [Client 22] Closing connection.
D [05/Nov/2017:15:17:10 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:10 +0100] [Job 1231] /usr/lib/cups/filter/pstoturboprint: line 80: kill: (1349) - No such process
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
I [05/Nov/2017:15:17:10 +0100] [Job 1231] Drucker ist bereit
D [05/Nov/2017:15:17:10 +0100] Discarding unused job-progress event...
D [05/Nov/2017:15:17:10 +0100] Discarding unused printer-state-changed event...
D [05/Nov/2017:15:17:10 +0100] [Job 1231] PID 1325 (/usr/lib/cups/filter/pstoturboprint) exited with no errors.
D [05/Nov/2017:15:17:10 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Job 1231] PID 1326 (/usr/lib/cups/backend/tpu) exited with no errors.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] Discarding unused job-state-changed event...
E [05/Nov/2017:15:17:11 +0100] [Job 1231] Job stopped due to filter errors; please consult the error_log file for details.
D [05/Nov/2017:15:17:11 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] Discarding unused printer-state-changed event...
D [05/Nov/2017:15:17:11 +0100] cupsdMarkDirty(---J-)
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] Accepted from 192.168.178.32:631 (IPv4)
D [05/Nov/2017:15:17:11 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [05/Nov/2017:15:17:11 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:11 +0100] [Client 20] 2.0 Get-Printer-Attributes 17
D [05/Nov/2017:15:17:11 +0100] Get-Printer-Attributes ipp://192.168.178.39:631/printers/Canon_MP550_series_TP
D [05/Nov/2017:15:17:11 +0100] [Client 20] Returning IPP successful-ok for Get-Printer-Attributes (ipp://192.168.178.39:631/printers/Canon_MP550_series_TP) from 192.168.178.32
D [05/Nov/2017:15:17:11 +0100] [Client 20] Content-Length: 1900
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1900, response=0x55767260(IPP_IDLE), pipe_pid=0, file=-1
D [05/Nov/2017:15:17:11 +0100] [Client 20] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [05/Nov/2017:15:17:11 +0100] [Client 20] bytes=0, http_state=0, data_remaining=0
D [05/Nov/2017:15:17:11 +0100] [Client 20] Waiting for request.
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] [Client 20] POST /printers/Canon_MP550_series_TP HTTP/1.1
D [05/Nov/2017:15:17:11 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [05/Nov/2017:15:17:11 +0100] [Client 20] No authentication data provided.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.
D [05/Nov/2017:15:17:11 +0100] cupsd is not idle any more, canceling shutdown.