D [23/Sep/2021:14:34:24 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [23/Sep/2021:14:34:24 +0500] [Client 233] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) D [23/Sep/2021:14:34:24 +0500] [Client 233] Closing connection. D [23/Sep/2021:14:34:24 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:24 +0500] [Job 29] Wrote 8192 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Read 8192 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Client 232] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) D [23/Sep/2021:14:34:24 +0500] [Client 232] Closing connection. D [23/Sep/2021:14:34:24 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:24 +0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:24 +0500] [Client 234] Server address is "/var/run/cups/cups.sock". D [23/Sep/2021:14:34:24 +0500] [Client 234] skipping getpeercon() D [23/Sep/2021:14:34:24 +0500] [Client 234] Accepted from localhost (Domain) D [23/Sep/2021:14:34:24 +0500] [Client 234] Waiting for request. D [23/Sep/2021:14:34:24 +0500] [Client 234] POST / HTTP/1.1 D [23/Sep/2021:14:34:24 +0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" D [23/Sep/2021:14:34:24 +0500] [Client 234] Read: status=200, state=6 D [23/Sep/2021:14:34:24 +0500] [Client 234] No authentication data provided. D [23/Sep/2021:14:34:24 +0500] [Client 234] 2.0 Get-Jobs 8 D [23/Sep/2021:14:34:24 +0500] Get-Jobs ipp://localhost/printers/ D [23/Sep/2021:14:34:24 +0500] [Client 234] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost. D [23/Sep/2021:14:34:24 +0500] [Client 234] Content-Length: 75 D [23/Sep/2021:14:34:24 +0500] [Client 234] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 D [23/Sep/2021:14:34:24 +0500] [Client 234] con->http=0x55d4fcea6bf0 D [23/Sep/2021:14:34:24 +0500] [Client 234] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x55d4fcea0ff0(IPP_STATE_DATA), pipe_pid=0, file=-1 D [23/Sep/2021:14:34:24 +0500] [Client 234] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 D [23/Sep/2021:14:34:24 +0500] [Client 234] bytes=0, http_state=0, data_remaining=75 D [23/Sep/2021:14:34:24 +0500] [Client 234] Flushing write buffer. D [23/Sep/2021:14:34:24 +0500] [Client 234] New state is HTTP_STATE_WAITING D [23/Sep/2021:14:34:24 +0500] [Client 234] Waiting for request. D [23/Sep/2021:14:34:24 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [23/Sep/2021:14:34:24 +0500] [Client 234] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) D [23/Sep/2021:14:34:24 +0500] [Client 234] Closing connection. D [23/Sep/2021:14:34:24 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:24 +0500] [Job 29] Wrote 8192 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Read 8192 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Wrote 8192 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Read 8192 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Wrote 8192 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Read 6669 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Wrote 6669 bytes of print data... D [23/Sep/2021:14:34:24 +0500] [Job 29] Sent 104973 bytes... D [23/Sep/2021:14:34:24 +0500] [Job 29] Waiting for read thread to exit... D [23/Sep/2021:14:34:24 +0500] [Job 29] Got USB transaction timeout during read. D [23/Sep/2021:14:34:25 +0500] [Job 29] Resetting printer. I [23/Sep/2021:14:34:25 +0500] Expiring subscriptions... D [23/Sep/2021:14:34:25 +0500] [Job 29] PID 4540 (/usr/lib/cups/backend/usb) exited with no errors. D [23/Sep/2021:14:34:25 +0500] [Job 29] time-at-completed=1632389665 D [23/Sep/2021:14:34:25 +0500] cupsdMarkDirty(----S) D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" I [23/Sep/2021:14:34:25 +0500] [Job 29] Job completed. I [23/Sep/2021:14:34:25 +0500] Expiring subscriptions... D [23/Sep/2021:14:34:25 +0500] cupsdMarkDirty(---J-) D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:25 +0500] cupsdMarkDirty(----S) D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:25 +0500] cupsdMarkDirty(---J-) D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files" D [23/Sep/2021:14:34:25 +0500] [Client 235] Server address is "/var/run/cups/cups.sock". D [23/Sep/2021:14:34:25 +0500] [Client 235] skipping getpeercon() D [23/Sep/2021:14:34:25 +0500] [Client 235] Accepted from localhost (Domain) D [23/Sep/2021:14:34:25 +0500] [Client 235] Waiting for request. D [23/Sep/2021:14:34:25 +0500] [Client 235] POST / HTTP/1.1 D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [23/Sep/2021:14:34:25 +0500] [Client 235] Read: status=200, state=6 D [23/Sep/2021:14:34:25 +0500] [Client 235] No authentication data provided. D [23/Sep/2021:14:34:25 +0500] [Client 235] 2.0 Get-Notifications 9 D [23/Sep/2021:14:34:25 +0500] Get-Notifications / D [23/Sep/2021:14:34:25 +0500] cupsdIsAuthorized: requesting-user-name="yevgeny" D [23/Sep/2021:14:34:25 +0500] [Client 235] Returning IPP successful-ok for Get-Notifications (/) from localhost. D [23/Sep/2021:14:34:25 +0500] [Client 235] Content-Length: 1127 D [23/Sep/2021:14:34:25 +0500] [Client 235] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 D [23/Sep/2021:14:34:25 +0500] [Client 235] con->http=0x55d4fcea6bf0 D [23/Sep/2021:14:34:25 +0500] [Client 235] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1127, response=0x55d4fcea4820(IPP_STATE_DATA), pipe_pid=0, file=-1 D [23/Sep/2021:14:34:25 +0500] [Client 235] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 D [23/Sep/2021:14:34:25 +0500] [Client 235] bytes=0, http_state=0, data_remaining=1127 D [23/Sep/2021:14:34:25 +0500] [Client 235] Flushing write buffer. D [23/Sep/2021:14:34:25 +0500] [Client 235] New state is HTTP_STATE_WAITING D [23/Sep/2021:14:34:25 +0500] [Client 235] Waiting for request. D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [23/Sep/2021:14:34:25 +0500] [Client 236] Server address is "/var/run/cups/cups.sock". D [23/Sep/2021:14:34:25 +0500] [Client 236] skipping getpeercon() D [23/Sep/2021:14:34:25 +0500] [Client 236] Accepted from localhost (Domain) D [23/Sep/2021:14:34:25 +0500] [Client 236] Waiting for request. D [23/Sep/2021:14:34:25 +0500] [Client 236] POST / HTTP/1.1 D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [23/Sep/2021:14:34:25 +0500] [Client 236] Read: status=200, state=6 D [23/Sep/2021:14:34:25 +0500] [Client 236] No authentication data provided. D [23/Sep/2021:14:34:25 +0500] [Client 236] 2.0 Get-Printer-Attributes 10 D [23/Sep/2021:14:34:25 +0500] Get-Printer-Attributes ipp://localhost/printers/Samsung-ML-1640-Series D [23/Sep/2021:14:34:25 +0500] [Client 236] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/Samsung-ML-1640-Series) from localhost. D [23/Sep/2021:14:34:25 +0500] [Client 236] Content-Length: 145 D [23/Sep/2021:14:34:25 +0500] [Client 236] cupsdSendHeader: code=200, type="application/ipp", auth_type=0 D [23/Sep/2021:14:34:25 +0500] [Client 236] con->http=0x55d4fceabe60 D [23/Sep/2021:14:34:25 +0500] [Client 236] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=145, response=0x55d4fcea4860(IPP_STATE_DATA), pipe_pid=0, file=-1 D [23/Sep/2021:14:34:25 +0500] [Client 236] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0 D [23/Sep/2021:14:34:25 +0500] [Client 236] bytes=0, http_state=0, data_remaining=145 D [23/Sep/2021:14:34:25 +0500] [Client 236] Flushing write buffer. D [23/Sep/2021:14:34:25 +0500] [Client 236] New state is HTTP_STATE_WAITING D [23/Sep/2021:14:34:25 +0500] [Client 236] Waiting for request. D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [23/Sep/2021:14:34:25 +0500] [Client 235] HTTP_STATE_WAITING Closing for error 32 (Broken pipe) D [23/Sep/2021:14:34:25 +0500] [Client 235] Closing connection. D [23/Sep/2021:14:34:25 +0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" I [23/Sep/2021:14:34:26 +0500] Expiring subscriptions... D [23/Sep/2021:14:34:26 +0500] [Job 29] Unloading... I [23/Sep/2021:14:34:54 +0500] Saving job.cache... I [23/Sep/2021:14:34:54 +0500] Saving subscriptions.conf... D [23/Sep/2021:14:34:54 +0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" I [23/Sep/2021:14:34:54 +0500] Expiring subscriptions...