Attachment 9729 Details for Bug 40996 – отладочный кусок лога

отладочный кусок лога

журнал CUPS при проблеме печати.txt (text/plain), 9.75 KB, created by Евгений Д. on 2021-09-23 13:29:41 MSK

(hide)

Description:

Filename:

MIME Type:

Creator: Евгений Д.

Created: 2021-09-23 13:29:41 MSK

Size: 9.75 KB

patch

obsolete

>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...
>

Actions: View

Attachments on bug 40996: 9729