Bugzilla – Attachment 143219 Details for
Bug 118467
Libreoffice Modifies pagesize (A4->A4.Duplex) when printing with hpcups driver
Home
|
New
|
Browse
|
Search
|
[?]
|
Reports
|
Help
|
New Account
|
Log In
[x]
|
Forgot Password
Login:
[x]
/var/log/cups/error_log when printing fails
log-lowriter-hpcups6700 (text/plain), 85.26 KB, created by
rkeller
on 2018-06-30 07:28:12 UTC
(
hide
)
Description:
/var/log/cups/error_log when printing fails
Filename:
MIME Type:
Creator:
rkeller
Created:
2018-06-30 07:28:12 UTC
Size:
85.26 KB
patch
obsolete
>D [28/Jun/2018:12:49:05 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:49:05 +0200] [Client 1] bytes=0, http_state=0, data_remaining=484 >D [28/Jun/2018:12:49:05 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:49:05 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:49:05 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:49:05 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:49:05 +0200] [Client 1] 2.0 Get-Jobs 310 >D [28/Jun/2018:12:49:05 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:49:05 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:49:05 +0200] [Client 1] Content-Length: 484 >D [28/Jun/2018:12:49:05 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:49:05 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:49:05 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=484, response=0x560367711f90(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:49:05 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:49:05 +0200] [Client 1] bytes=0, http_state=0, data_remaining=484 >D [28/Jun/2018:12:49:05 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:49:05 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:49:05 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Job 3154] PID 24979 (/usr/lib/cups/filter/gstoraster) exited with no errors. >D [28/Jun/2018:12:49:05 +0200] [Job 3154] PID 24980 (/usr/lib/cups/filter/hpcups) exited with no errors. >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Read 8192 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Read 8192 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Read 8192 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Read 3221 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Wrote 3221 bytes of print data... >D [28/Jun/2018:12:49:05 +0200] [Job 3154] STATE: +cups-waiting-for-job-completed >D [28/Jun/2018:12:49:05 +0200] cupsdMarkDirty(P----) >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:05 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Waiting for printer to finish. >D [28/Jun/2018:12:49:05 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Job 3154] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO >D [28/Jun/2018:12:49:05 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:05 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:49:05 +0200] [Notifier] state=3 >D [28/Jun/2018:12:49:05 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:49:05 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:49:05 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:49:05 +0200] [Client 1] 2.0 Get-Jobs 311 >D [28/Jun/2018:12:49:05 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:49:05 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:49:05 +0200] [Client 1] Content-Length: 495 >D [28/Jun/2018:12:49:05 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:49:05 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:49:05 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=495, response=0x560367713440(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:49:05 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:49:05 +0200] [Client 1] bytes=0, http_state=0, data_remaining=495 >D [28/Jun/2018:12:49:05 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:49:05 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:49:05 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:05 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:49:05 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:49:05 +0200] [Client 1] 2.0 Get-Jobs 312 >D [28/Jun/2018:12:49:05 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:49:05 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:49:05 +0200] [Client 1] Content-Length: 495 >D [28/Jun/2018:12:49:05 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:49:05 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:49:05 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=495, response=0x560367713330(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:49:05 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:49:05 +0200] [Client 1] bytes=0, http_state=0, data_remaining=495 >D [28/Jun/2018:12:49:05 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:49:05 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:49:05 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:49:05 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >I [28/Jun/2018:12:49:06 +0200] Expiring subscriptions... >I [28/Jun/2018:12:49:09 +0200] Expiring subscriptions... >D [28/Jun/2018:12:49:09 +0200] [Job 3154] PID 24981 (/usr/lib/cups/backend/socket) exited with no errors. >D [28/Jun/2018:12:49:09 +0200] cupsdMarkDirty(P----) >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:09 +0200] [Job 3154] time-at-completed=1530182949 >D [28/Jun/2018:12:49:09 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >I [28/Jun/2018:12:49:09 +0200] [Job 3154] Job completed. >I [28/Jun/2018:12:49:09 +0200] Expiring subscriptions... >D [28/Jun/2018:12:49:09 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:09 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:49:09 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:09 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:09 +0200] [Notifier] state=3 >D [28/Jun/2018:12:49:09 +0200] [Notifier] JobCompleted >D [28/Jun/2018:12:49:09 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:49:09 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:49:09 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:49:09 +0200] [Client 1] 2.0 Get-Jobs 313 >D [28/Jun/2018:12:49:09 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:49:09 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:49:09 +0200] [Client 1] Content-Length: 75 >D [28/Jun/2018:12:49:09 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:49:09 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:49:09 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x560367712870(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:49:09 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:49:09 +0200] [Client 1] bytes=0, http_state=0, data_remaining=75 >D [28/Jun/2018:12:49:09 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:49:09 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:49:09 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:49:09 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [28/Jun/2018:12:49:09 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:49:09 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:49:09 +0200] [Client 1] 2.0 Get-Jobs 314 >D [28/Jun/2018:12:49:09 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:49:09 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:49:09 +0200] [Client 1] Content-Length: 75 >D [28/Jun/2018:12:49:09 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:49:09 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:49:09 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x560367712900(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:49:09 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:49:09 +0200] [Client 1] bytes=0, http_state=0, data_remaining=75 >D [28/Jun/2018:12:49:09 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:49:09 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:49:09 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:49:09 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >I [28/Jun/2018:12:49:10 +0200] Expiring subscriptions... >D [28/Jun/2018:12:49:10 +0200] [Job 3154] Unloading... >I [28/Jun/2018:12:49:25 +0200] Saving printers.conf... >I [28/Jun/2018:12:49:25 +0200] Saving job.cache... >I [28/Jun/2018:12:49:25 +0200] Saving subscriptions.conf... >D [28/Jun/2018:12:49:25 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" >I [28/Jun/2018:12:49:25 +0200] Expiring subscriptions... >D [28/Jun/2018:12:49:25 +0200] Report: clients=2 >D [28/Jun/2018:12:49:25 +0200] Report: jobs=27 >D [28/Jun/2018:12:49:25 +0200] Report: jobs-active=0 >D [28/Jun/2018:12:49:25 +0200] Report: printers=2 >D [28/Jun/2018:12:49:25 +0200] Report: stringpool-string-count=3648 >D [28/Jun/2018:12:49:25 +0200] Report: stringpool-alloc-bytes=12128 >D [28/Jun/2018:12:49:25 +0200] Report: stringpool-total-bytes=70416 >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [28/Jun/2018:12:50:42 +0200] [Client 11] Server address is "/run/cups/cups.sock". >D [28/Jun/2018:12:50:42 +0200] [Client 11] Accepted from localhost (Domain) >D [28/Jun/2018:12:50:42 +0200] [Client 11] Waiting for request. >I [28/Jun/2018:12:50:42 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:42 +0200] Report: clients=3 >D [28/Jun/2018:12:50:42 +0200] Report: jobs=27 >D [28/Jun/2018:12:50:42 +0200] Report: jobs-active=0 >D [28/Jun/2018:12:50:42 +0200] Report: printers=2 >D [28/Jun/2018:12:50:42 +0200] Report: stringpool-string-count=3648 >D [28/Jun/2018:12:50:42 +0200] Report: stringpool-alloc-bytes=12128 >D [28/Jun/2018:12:50:42 +0200] Report: stringpool-total-bytes=70416 >D [28/Jun/2018:12:50:42 +0200] [Client 11] POST / HTTP/1.1 >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients" >D [28/Jun/2018:12:50:42 +0200] [Client 11] Read: status=200, state=6 >D [28/Jun/2018:12:50:42 +0200] [Client 11] No authentication data provided. >D [28/Jun/2018:12:50:42 +0200] [Client 11] 2.0 CUPS-Get-Printers 12 >D [28/Jun/2018:12:50:42 +0200] CUPS-Get-Printers >D [28/Jun/2018:12:50:42 +0200] [Client 11] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost. >D [28/Jun/2018:12:50:42 +0200] [Client 11] Content-Length: 2490 >D [28/Jun/2018:12:50:42 +0200] [Client 11] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:42 +0200] [Client 11] con->http=0x560367729080 >D [28/Jun/2018:12:50:42 +0200] [Client 11] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=2490, response=0x56036770f560(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:42 +0200] [Client 11] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:42 +0200] [Client 11] bytes=0, http_state=0, data_remaining=2490 >D [28/Jun/2018:12:50:42 +0200] [Client 11] Flushing write buffer. >D [28/Jun/2018:12:50:42 +0200] [Client 11] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:42 +0200] [Client 11] Waiting for request. >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [28/Jun/2018:12:50:42 +0200] [Client 11] POST / HTTP/1.1 >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [28/Jun/2018:12:50:42 +0200] [Client 11] Read: status=200, state=6 >D [28/Jun/2018:12:50:42 +0200] [Client 11] No authentication data provided. >D [28/Jun/2018:12:50:42 +0200] [Client 11] 2.0 CUPS-Get-Default 13 >D [28/Jun/2018:12:50:42 +0200] CUPS-Get-Default >D [28/Jun/2018:12:50:42 +0200] CUPS-Get-Default client-error-not-found: Aucune imprimante par défaut. >D [28/Jun/2018:12:50:42 +0200] [Client 11] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost. >D [28/Jun/2018:12:50:42 +0200] [Client 11] Content-Length: 124 >D [28/Jun/2018:12:50:42 +0200] [Client 11] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:42 +0200] [Client 11] con->http=0x560367729080 >D [28/Jun/2018:12:50:42 +0200] [Client 11] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=124, response=0x560367713490(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:42 +0200] [Client 11] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:42 +0200] [Client 11] bytes=0, http_state=0, data_remaining=124 >D [28/Jun/2018:12:50:42 +0200] [Client 11] Flushing write buffer. >D [28/Jun/2018:12:50:42 +0200] [Client 11] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:42 +0200] [Client 11] Waiting for request. >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [28/Jun/2018:12:50:42 +0200] [Client 11] POST / HTTP/1.1 >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [28/Jun/2018:12:50:42 +0200] [Client 11] Read: status=200, state=6 >D [28/Jun/2018:12:50:42 +0200] [Client 11] No authentication data provided. >D [28/Jun/2018:12:50:42 +0200] [Client 11] 2.0 CUPS-Get-Default 14 >D [28/Jun/2018:12:50:42 +0200] CUPS-Get-Default >D [28/Jun/2018:12:50:42 +0200] CUPS-Get-Default client-error-not-found: Aucune imprimante par défaut. >D [28/Jun/2018:12:50:42 +0200] [Client 11] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost. >D [28/Jun/2018:12:50:42 +0200] [Client 11] Content-Length: 124 >D [28/Jun/2018:12:50:42 +0200] [Client 11] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:42 +0200] [Client 11] con->http=0x560367729080 >D [28/Jun/2018:12:50:42 +0200] [Client 11] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=124, response=0x56036770f560(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:42 +0200] [Client 11] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:42 +0200] [Client 11] bytes=0, http_state=0, data_remaining=124 >D [28/Jun/2018:12:50:42 +0200] [Client 11] Flushing write buffer. >D [28/Jun/2018:12:50:42 +0200] [Client 11] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:42 +0200] [Client 11] Waiting for request. >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [28/Jun/2018:12:50:42 +0200] [Client 11] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) >D [28/Jun/2018:12:50:42 +0200] [Client 11] Closing connection. >D [28/Jun/2018:12:50:42 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" >I [28/Jun/2018:12:50:43 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:44 +0200] [Client 10] POST / HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [28/Jun/2018:12:50:44 +0200] [Client 10] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 10] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 10] 2.0 Get-Printer-Attributes 15 >D [28/Jun/2018:12:50:44 +0200] Get-Printer-Attributes ipp://localhost:631/printers/HP_Officejet_6700 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/HP_Officejet_6700) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 10] Content-Length: 1266 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >I [28/Jun/2018:12:50:44 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:44 +0200] [Client 10] con->http=0x56036771dbf0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1266, response=0x560367713490(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] bytes=0, http_state=0, data_remaining=1266 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 10] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 10] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [28/Jun/2018:12:50:44 +0200] [Client 10] POST /printers/HP_Officejet_6700 HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [28/Jun/2018:12:50:44 +0200] [Client 10] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 10] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 10] 2.0 Get-Printer-Attributes 16 >D [28/Jun/2018:12:50:44 +0200] Get-Printer-Attributes ipp://localhost/printers/HP_Officejet_6700 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/HP_Officejet_6700) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 10] Content-Length: 40767 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] con->http=0x56036771dbf0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=40767, response=0x56036770f560(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] bytes=0, http_state=0, data_remaining=40767 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 10] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 10] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Active clients" >D [28/Jun/2018:12:50:44 +0200] [Client 10] POST /printers/HP_Officejet_6700 HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" >D [28/Jun/2018:12:50:44 +0200] [Client 10] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 10] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 10] 2.0 Create-Job 17 >D [28/Jun/2018:12:50:44 +0200] Create-Job ipp://localhost/printers/HP_Officejet_6700 >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Applying default options... >D [28/Jun/2018:12:50:44 +0200] add_job: requesting-user-name="keikoz" >D [28/Jun/2018:12:50:44 +0200] Adding default job-sheets values "none,none"... >I [28/Jun/2018:12:50:44 +0200] [Job 3155] Adding start banner page "none". >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >I [28/Jun/2018:12:50:44 +0200] [Job 3155] Queued on "HP_Officejet_6700" by "keikoz". >D [28/Jun/2018:12:50:44 +0200] [Client 10] Returning IPP successful-ok for Create-Job (ipp://localhost/printers/HP_Officejet_6700) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 10] Content-Length: 202 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] con->http=0x56036771dbf0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=202, response=0x560367704560(IPP_STATE_IDLE), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] bytes=0, http_state=0, data_remaining=202 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 10] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 10] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:44 +0200] [Notifier] JobCreated >D [28/Jun/2018:12:50:44 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 1] 2.0 Get-Jobs 315 >D [28/Jun/2018:12:50:44 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:44 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 1] Content-Length: 431 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=431, response=0x560367715280(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] bytes=0, http_state=0, data_remaining=431 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 10] POST /printers/HP_Officejet_6700 HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 10] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 10] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 10] 2.0 Send-Document 18 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Read: status=100, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Read: status=100, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 1] 2.0 Get-Jobs 316 >D [28/Jun/2018:12:50:44 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:44 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 1] Content-Length: 431 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Read: status=100, state=6 >D [28/Jun/2018:12:50:44 +0200] Send-Document ipp://localhost:631/printers/HP_Officejet_6700 >D [28/Jun/2018:12:50:44 +0200] cupsdIsAuthorized: requesting-user-name="keikoz" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Auto-typing file... >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Request file type is application/pdf. >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >I [28/Jun/2018:12:50:44 +0200] [Job 3155] File of type application/pdf queued by "keikoz". >I [28/Jun/2018:12:50:44 +0200] [Job 3155] Adding end banner page "none". >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] time-at-processing=1530183044 >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:44 +0200] [Job 3155] 3 filters for job: >D [28/Jun/2018:12:50:44 +0200] [Job 3155] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 99) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] hpcups (application/vnd.cups-raster to printer/HP_Officejet_6700, cost 0) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] job-sheets=none,none >D [28/Jun/2018:12:50:44 +0200] [Job 3155] argv[0]="HP_Officejet_6700" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] argv[1]="3155" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] argv[2]="keikoz" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] argv[3]="PlanningTravail.odt" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] argv[4]="1" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] argv[5]="Duplex=None InputSlot=Tray1 PageSize=A4.Duplex job-uuid=urn:uuid:85bae156-3acd-3fd7-6141-240a734334ad job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1530183044 time-at-processing=1530183044 document-name-supplied=DS9pHR" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] argv[6]="/var/spool/cups/d03155-001" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[0]="CUPS_CACHEDIR=/var/cache/cups" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[1]="CUPS_DATADIR=/usr/share/cups" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[6]="CUPS_SERVERROOT=/etc/cups" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[7]="CUPS_STATEDIR=/run/cups" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[8]="HOME=/var/spool/cups/tmp" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[10]="SERVER_ADMIN=root@kdesktop" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[11]="SOFTWARE=CUPS/2.2.8" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[12]="TMPDIR=/var/spool/cups/tmp" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[13]="USER=root" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[14]="CUPS_MAX_MESSAGE=2047" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[15]="CUPS_SERVER=/run/cups/cups.sock" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[16]="CUPS_ENCRYPTION=IfRequested" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[17]="IPP_PORT=631" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[18]="CHARSET=utf-8" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[19]="LANG=fr_FR.UTF-8" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[20]="PPD=/etc/cups/ppd/HP_Officejet_6700.ppd" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[21]="RIP_MAX_CACHE=128m" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[22]="CONTENT_TYPE=application/pdf" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[23]="DEVICE_URI=socket://192.168.0.100:9100" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[24]="PRINTER_INFO=HP Officejet 6700" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[25]="PRINTER_LOCATION=Bureau" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[26]="PRINTER=HP_Officejet_6700" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[27]="PRINTER_STATE_REASONS=none" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[28]="CUPS_FILETYPE=document" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raster" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[30]="AUTH_I****" >I [28/Jun/2018:12:50:44 +0200] [Job 3155] Started filter /usr/lib/cups/filter/pdftopdf (PID 25052) >I [28/Jun/2018:12:50:44 +0200] [Job 3155] Started filter /usr/lib/cups/filter/gstoraster (PID 25053) >I [28/Jun/2018:12:50:44 +0200] [Job 3155] Started filter /usr/lib/cups/filter/hpcups (PID 25054) >I [28/Jun/2018:12:50:44 +0200] [Job 3155] Started backend /usr/lib/cups/backend/socket (PID 25055) >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 10] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/HP_Officejet_6700) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 10] Content-Length: 172 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=431, response=0x56036770bb50(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] bytes=0, http_state=0, data_remaining=431 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 10] con->http=0x56036771dbf0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=172, response=0x560367724db0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 10] bytes=0, http_state=0, data_remaining=172 >D [28/Jun/2018:12:50:44 +0200] [Client 10] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 10] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 10] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] OUTFORMAT=\"(null)\", so output format will be CUPS/PWG Raster >D [28/Jun/2018:12:50:44 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:44 +0200] [Notifier] JobState >D [28/Jun/2018:12:50:44 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 1] 2.0 Get-Jobs 317 >D [28/Jun/2018:12:50:44 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:44 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 1] Content-Length: 435 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=435, response=0x560367715280(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] bytes=0, http_state=0, data_remaining=435 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 1] 2.0 Get-Jobs 318 >D [28/Jun/2018:12:50:44 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:44 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 1] Content-Length: 435 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Job 3155] STATE: +connecting-to-device >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Looking up \"192.168.0.100\"... >D [28/Jun/2018:12:50:44 +0200] [Job 3155] STATE: -connecting-to-device >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] 192.168.0.100=192.168.0.100 >D [28/Jun/2018:12:50:44 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:44 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=435, response=0x560367704560(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] bytes=0, http_state=0, data_remaining=435 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] prtGeneralCurrentLocalization type is 5, expected 2! >D [28/Jun/2018:12:50:44 +0200] [Job 3155] backendWaitLoop(snmp_fd=5, addr=0x55b5afe6cdf8, side_cb=0x55b5add28ec0) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] pdftopdf: Last filter determined by the PPD: hpcups; FINAL_CONTENT_TYPE: application/vnd.cups-raster => pdftopdf will not log pages in page_log. >D [28/Jun/2018:12:50:44 +0200] [Job 3155] PID 25052 (/usr/lib/cups/filter/pdftopdf) exited with no errors. >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Color Manager: Calibration Mode/Off >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Calling FindDeviceById(cups-HP_Officejet_6700) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Found device /org/freedesktop/ColorManager/devices/cups_HP_Officejet_6700 >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Calling FindDeviceById(cups-HP_Officejet_6700) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Found device /org/freedesktop/ColorManager/devices/cups_HP_Officejet_6700 >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Calling GetProfileForQualifiers(RGB.Plain....) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Found profile /org/freedesktop/ColorManager/profiles/HP_Officejet_6700_RGB__ >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Calling org.freedesktop.ColorManager.Profile.Get(Filename) >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Use profile filename: \'\' >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Color Manager: ICC Profile: >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Ghostscript using Any-Part-of-Pixel method to fill paths. >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Ghostscript command line: gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -dShowAcroForm -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=cups -sMediaType=Plain -sOutputType=0 -r600x600 -dMediaPosition=1 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=841 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=17 -dcupsInteger0=26 -scupsPageSizeName=A4.Duplex -I/usr/share/cups/fonts -c \'<</.HWMargins[9.360000 33.192001 9.359985 42.552002] /Margins[0 0]>>setpagedevice\' -f -_ >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[0]=\"CUPS_CACHEDIR=/var/cache/cups\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[1]=\"CUPS_DATADIR=/usr/share/cups\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[2]=\"CUPS_DOCROOT=/usr/share/cups/doc\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[3]=\"CUPS_FONTPATH=/usr/share/cups/fonts\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[4]=\"CUPS_REQUESTROOT=/var/spool/cups\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[5]=\"CUPS_SERVERBIN=/usr/lib/cups\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[6]=\"CUPS_SERVERROOT=/etc/cups\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[7]=\"CUPS_STATEDIR=/run/cups\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[8]=\"HOME=/var/spool/cups/tmp\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[9]=\"PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[10]=\"SERVER_ADMIN=root@kdesktop\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[11]=\"SOFTWARE=CUPS/2.2.8\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[12]=\"TMPDIR=/var/spool/cups/tmp\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[13]=\"USER=root\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[14]=\"CUPS_MAX_MESSAGE=2047\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[15]=\"CUPS_SERVER=/run/cups/cups.sock\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[16]=\"CUPS_ENCRYPTION=IfRequested\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[17]=\"IPP_PORT=631\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[18]=\"CHARSET=utf-8\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[19]=\"LANG=fr_FR.UTF-8\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[20]=\"PPD=/etc/cups/ppd/HP_Officejet_6700.ppd\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[21]=\"RIP_MAX_CACHE=128m\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[22]=\"CONTENT_TYPE=application/pdf\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[23]=\"DEVICE_URI=socket://192.168.0.100:9100\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[24]=\"PRINTER_INFO=HP Officejet 6700\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[25]=\"PRINTER_LOCATION=Bureau\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[26]=\"PRINTER=HP_Officejet_6700\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[27]=\"PRINTER_STATE_REASONS=none\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[28]=\"CUPS_FILETYPE=document\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[29]=\"FINAL_CONTENT_TYPE=application/vnd.cups-raster\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] envp[30]=\"AUTH_INFO_REQUIRED=none\" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Start rendering... >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Set job-printer-state-message to "Start rendering...", current level=INFO >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Processing page 1... >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Job 3155] Set job-printer-state-message to "Processing page 1...", current level=INFO >D [28/Jun/2018:12:50:44 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:44 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:44 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:44 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:50:44 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 1] 2.0 Get-Jobs 319 >D [28/Jun/2018:12:50:44 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:44 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 1] Content-Length: 485 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=485, response=0x56036770bd20(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] bytes=0, http_state=0, data_remaining=485 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:44 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:44 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:44 +0200] [Client 1] 2.0 Get-Jobs 320 >D [28/Jun/2018:12:50:44 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:44 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:44 +0200] [Client 1] Content-Length: 485 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:44 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=485, response=0x560367724df0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:44 +0200] [Client 1] bytes=0, http_state=0, data_remaining=485 >D [28/Jun/2018:12:50:44 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:44 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:44 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:44 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Job 3155] PAGE: 1 1\r >D [28/Jun/2018:12:50:45 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >I [28/Jun/2018:12:50:45 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Connecting to 192.168.0.100:9100 >D [28/Jun/2018:12:50:45 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:45 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:50:45 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:45 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:45 +0200] [Client 1] 2.0 Get-Jobs 321 >D [28/Jun/2018:12:50:45 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:45 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:45 +0200] [Client 1] Content-Length: 485 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=485, response=0x56036770bd20(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] bytes=0, http_state=0, data_remaining=485 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:45 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:45 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:45 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:45 +0200] [Client 1] 2.0 Get-Jobs 322 >D [28/Jun/2018:12:50:45 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:45 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:45 +0200] [Client 1] Content-Length: 485 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=485, response=0x56036772a3e0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] bytes=0, http_state=0, data_remaining=485 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:45 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:45 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Connexion à l\'imprimante en cours. >D [28/Jun/2018:12:50:45 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Set job-printer-state-message to "Connexion à l\'imprimante en cours.", current level=INFO >D [28/Jun/2018:12:50:45 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:45 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:45 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:50:45 +0200] [Job 3155] STATE: -connecting-to-device >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Connecté à l\'imprimante. >D [28/Jun/2018:12:50:45 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Set job-printer-state-message to "Connecté à l\'imprimante.", current level=INFO >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Connected to 192.168.0.100:9100... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x55b5afe6cdf8, use_bc=1, side_cb=0x55b5add28ec0) >D [28/Jun/2018:12:50:45 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:45 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:45 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:50:45 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:45 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:45 +0200] [Client 1] 2.0 Get-Jobs 323 >D [28/Jun/2018:12:50:45 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:45 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:45 +0200] [Client 1] Content-Length: 491 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=491, response=0x560367722f00(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] bytes=0, http_state=0, data_remaining=491 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:45 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:45 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:45 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:45 +0200] [Client 1] 2.0 Get-Jobs 324 >D [28/Jun/2018:12:50:45 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:45 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:45 +0200] [Client 1] Content-Length: 491 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:45 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=491, response=0x56036770bd20(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:45 +0200] [Client 1] bytes=0, http_state=0, data_remaining=491 >D [28/Jun/2018:12:50:45 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:45 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:45 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:45 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 1731 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 1731 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 1736 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 1736 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 1747 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 1747 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 1694 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 1694 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 1798 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 1798 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 1693 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 1693 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 1792 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 1792 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:45 +0200] [Job 3155] Read 8192 bytes of print data... >I [28/Jun/2018:12:50:46 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >I [28/Jun/2018:12:50:55 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Processing page 2... >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Set job-printer-state-message to "Processing page 2...", current level=INFO >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:55 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:55 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:50:55 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:55 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:55 +0200] [Client 1] 2.0 Get-Jobs 325 >D [28/Jun/2018:12:50:55 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:55 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:55 +0200] [Client 1] Content-Length: 485 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=485, response=0x560367723050(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] bytes=0, http_state=0, data_remaining=485 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:55 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:55 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:55 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:55 +0200] [Client 1] 2.0 Get-Jobs 326 >D [28/Jun/2018:12:50:55 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:55 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:55 +0200] [Client 1] Content-Length: 485 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=485, response=0x560367723470(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] bytes=0, http_state=0, data_remaining=485 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:55 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:55 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Rendering completed >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Set job-printer-state-message to "Rendering completed", current level=INFO >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:55 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:55 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:50:55 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:55 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:55 +0200] [Client 1] 2.0 Get-Jobs 327 >D [28/Jun/2018:12:50:55 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:55 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:55 +0200] [Client 1] Content-Length: 484 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=484, response=0x560367722f00(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] bytes=0, http_state=0, data_remaining=484 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:55 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:55 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:55 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:55 +0200] [Client 1] 2.0 Get-Jobs 328 >D [28/Jun/2018:12:50:55 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:55 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:55 +0200] [Client 1] Content-Length: 484 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=484, response=0x560367723600(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] bytes=0, http_state=0, data_remaining=484 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:55 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:55 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Job 3155] PID 25053 (/usr/lib/cups/filter/gstoraster) exited with no errors. >D [28/Jun/2018:12:50:55 +0200] [Job 3155] PID 25054 (/usr/lib/cups/filter/hpcups) exited with no errors. >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 8192 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Read 3221 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Wrote 3221 bytes of print data... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] STATE: +cups-waiting-for-job-completed >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(P----) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Waiting for printer to finish. >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Job 3155] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO >D [28/Jun/2018:12:50:55 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:55 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:55 +0200] [Notifier] JobProgress >D [28/Jun/2018:12:50:55 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:55 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:55 +0200] [Client 1] 2.0 Get-Jobs 329 >D [28/Jun/2018:12:50:55 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:55 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:55 +0200] [Client 1] Content-Length: 495 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=495, response=0x560367723950(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] bytes=0, http_state=0, data_remaining=495 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:55 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:55 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:55 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:55 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:55 +0200] [Client 1] 2.0 Get-Jobs 330 >D [28/Jun/2018:12:50:55 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:55 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:55 +0200] [Client 1] Content-Length: 495 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:55 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=495, response=0x560367722f00(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:55 +0200] [Client 1] bytes=0, http_state=0, data_remaining=495 >D [28/Jun/2018:12:50:55 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:55 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:55 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:55 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >I [28/Jun/2018:12:50:56 +0200] Expiring subscriptions... >I [28/Jun/2018:12:50:59 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:59 +0200] [Job 3155] PID 25055 (/usr/lib/cups/backend/socket) exited with no errors. >D [28/Jun/2018:12:50:59 +0200] cupsdMarkDirty(P----) >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:59 +0200] [Job 3155] time-at-completed=1530183059 >D [28/Jun/2018:12:50:59 +0200] cupsdMarkDirty(----S) >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >I [28/Jun/2018:12:50:59 +0200] [Job 3155] Job completed. >I [28/Jun/2018:12:50:59 +0200] Expiring subscriptions... >D [28/Jun/2018:12:50:59 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:59 +0200] Discarding unused printer-state-changed event... >D [28/Jun/2018:12:50:59 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:59 +0200] cupsdMarkDirty(---J-) >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:59 +0200] [Notifier] state=3 >D [28/Jun/2018:12:50:59 +0200] [Notifier] JobCompleted >D [28/Jun/2018:12:50:59 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files" >D [28/Jun/2018:12:50:59 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:59 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:59 +0200] [Client 1] 2.0 Get-Jobs 331 >D [28/Jun/2018:12:50:59 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:59 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:59 +0200] [Client 1] Content-Length: 75 >D [28/Jun/2018:12:50:59 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:59 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:59 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x560367723e30(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:59 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:59 +0200] [Client 1] bytes=0, http_state=0, data_remaining=75 >D [28/Jun/2018:12:50:59 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:59 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:59 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [28/Jun/2018:12:50:59 +0200] [Client 1] POST / HTTP/1.1 >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [28/Jun/2018:12:50:59 +0200] [Client 1] Read: status=200, state=6 >D [28/Jun/2018:12:50:59 +0200] [Client 1] No authentication data provided. >D [28/Jun/2018:12:50:59 +0200] [Client 1] 2.0 Get-Jobs 332 >D [28/Jun/2018:12:50:59 +0200] Get-Jobs ipp://keikoz@localhost:631/printers/ >D [28/Jun/2018:12:50:59 +0200] [Client 1] Returning IPP successful-ok for Get-Jobs (ipp://keikoz@localhost:631/printers/) from localhost. >D [28/Jun/2018:12:50:59 +0200] [Client 1] Content-Length: 75 >D [28/Jun/2018:12:50:59 +0200] [Client 1] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 >D [28/Jun/2018:12:50:59 +0200] [Client 1] con->http=0x560367717970 >D [28/Jun/2018:12:50:59 +0200] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x5603677034b0(IPP_STATE_DATA), pipe_pid=0, file=-1 >D [28/Jun/2018:12:50:59 +0200] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 >D [28/Jun/2018:12:50:59 +0200] [Client 1] bytes=0, http_state=0, data_remaining=75 >D [28/Jun/2018:12:50:59 +0200] [Client 1] Flushing write buffer. >D [28/Jun/2018:12:50:59 +0200] [Client 1] New state is HTTP_STATE_WAITING >D [28/Jun/2018:12:50:59 +0200] [Client 1] Waiting for request. >D [28/Jun/2018:12:50:59 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >I [28/Jun/2018:12:51:00 +0200] Expiring subscriptions... >D [28/Jun/2018:12:51:00 +0200] [Job 3155] Unloading... >I [28/Jun/2018:12:51:15 +0200] Saving printers.conf... >I [28/Jun/2018:12:51:15 +0200] Saving job.cache... >I [28/Jun/2018:12:51:15 +0200] Saving subscriptions.conf... >D [28/Jun/2018:12:51:15 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" >I [28/Jun/2018:12:51:15 +0200] Expiring subscriptions... >I [28/Jun/2018:12:55:45 +0200] Expiring subscriptions... >D [28/Jun/2018:12:55:45 +0200] cupsdAddCert: Adding certificate for PID 0 >D [28/Jun/2018:12:55:45 +0200] Closing client 10 after 300 seconds of inactivity. >D [28/Jun/2018:12:55:45 +0200] [Client 10] Closing connection. >D [28/Jun/2018:12:55:45 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" >D [28/Jun/2018:12:55:45 +0200] Report: clients=1 >D [28/Jun/2018:12:55:45 +0200] Report: jobs=28 >D [28/Jun/2018:12:55:45 +0200] Report: jobs-active=0 >D [28/Jun/2018:12:55:45 +0200] Report: printers=2 >D [28/Jun/2018:12:55:45 +0200] Report: stringpool-string-count=3906 >D [28/Jun/2018:12:55:45 +0200] Report: stringpool-alloc-bytes=12160 >D [28/Jun/2018:12:55:45 +0200] Report: stringpool-total-bytes=75808 >I [28/Jun/2018:12:56:00 +0200] Expiring subscriptions... >D [28/Jun/2018:12:56:00 +0200] Closing client 1 after 300 seconds of inactivity. >D [28/Jun/2018:12:56:00 +0200] [Client 1] Closing connection. >D [28/Jun/2018:12:56:00 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
<b>You cannot view the attachment while viewing its details because your browser does not support IFRAMEs. <a href="attachment.cgi?id=143219">View the attachment on a separate page</a>.</b>
View Attachment As Raw
Actions:
View
Attachments on
bug 118467
:
143218
| 143219