Принтеры Ricoh: "filter failed"

Areafix_ex · February 4, 2019, 9:21am

После декабрьского обновления принтеры Ricoh вываливаются с “filter failed”
OpenSuSE 15.0 4.12.14-lp150.12.45-default

Что именно обновилось - сказать сложно, но предполагаю, что cups.

Может ли кто помочь и что необходимо для диагностики?
Откат cups проблему не устраняет.

Lazy_Kent · February 4, 2019, 6:39pm

Посмотрите в /var/log/cups/

Areafix_ex · February 4, 2019, 10:16pm

Вопрос - что там искать?
Все 4 упомянутых фильтра запускаются исправно (по крайней мере без параметров)

/var/log/cups/error_log


I [04/Feb/2019:23:49:37 +0300] Expiring subscriptions...
I [04/Feb/2019:23:49:38 +0300] Expiring subscriptions...
D [04/Feb/2019:23:49:39 +0300] [Job 652] prtGeneralCurrentLocalization type is 0, expected 2!
D [04/Feb/2019:23:49:39 +0300] [Job 652] backendWaitLoop(snmp_fd=5, addr=0x5577a3b058e8, side_cb=0x5577a3678590)
I [04/Feb/2019:23:49:39 +0300] Expiring subscriptions...
D [04/Feb/2019:23:49:39 +0300] [Job 652] Connecting to 10.100.10.110:9100
D [04/Feb/2019:23:49:39 +0300] [Job 652] Connecting to printer.
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(----S)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] Discarding unused printer-state-changed event...
D [04/Feb/2019:23:49:39 +0300] [Notifier] state=3
D [04/Feb/2019:23:49:39 +0300] [Notifier] JobProgress
D [04/Feb/2019:23:49:39 +0300] [Client 927] POST / HTTP/1.1
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] Read: status=200, state=6
D [04/Feb/2019:23:49:39 +0300] [Client 927] No authentication data provided.
D [04/Feb/2019:23:49:39 +0300] [Client 927] 2.0 Get-Jobs 22427
D [04/Feb/2019:23:49:39 +0300] Get-Jobs ipp://pc221@localhost:631/printers/
D [04/Feb/2019:23:49:39 +0300] [Client 927] Returning IPP successful-ok for Get-Jobs (ipp://pc221@localhost:631/printers/) from localhost
D [04/Feb/2019:23:49:39 +0300] [Client 927] Content-Length: 361
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] con->http=0x55a354bed570
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=361, response=0x55a354bbaf70(IPP_STATE_DATA), pipe_pid=0, file=-1
D [04/Feb/2019:23:49:39 +0300] [Client 927] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] bytes=0, http_state=0, data_remaining=361
D [04/Feb/2019:23:49:39 +0300] [Client 927] Flushing write buffer.
D [04/Feb/2019:23:49:39 +0300] [Client 927] New state is HTTP_STATE_WAITING
D [04/Feb/2019:23:49:39 +0300] [Client 927] Waiting for request.
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Job 652] STATE: -connecting-to-device
D [04/Feb/2019:23:49:39 +0300] [Job 652] Connected to printer.
D [04/Feb/2019:23:49:39 +0300] [Job 652] Connected to 10.100.10.110:9100...
D [04/Feb/2019:23:49:39 +0300] [Job 652] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x5577a3b058e8, use_bc=1, side_cb=0x5577a3678590)
D [04/Feb/2019:23:49:39 +0300] [Job 652] Read 20 bytes of print data...
D [04/Feb/2019:23:49:39 +0300] [Job 652] Wrote 20 bytes of print data...
D [04/Feb/2019:23:49:39 +0300] [Job 652] STATE: +cups-waiting-for-job-completed
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(P----)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(---J-)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Job 652] Waiting for printer to finish.
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(----S)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] Discarding unused printer-state-changed event...
D [04/Feb/2019:23:49:39 +0300] [Client 927] POST / HTTP/1.1
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] Read: status=200, state=6
D [04/Feb/2019:23:49:39 +0300] [Client 927] No authentication data provided.
D [04/Feb/2019:23:49:39 +0300] [Client 927] 2.0 Get-Jobs 22428
D [04/Feb/2019:23:49:39 +0300] Get-Jobs ipp://pc221@localhost:631/printers/
D [04/Feb/2019:23:49:39 +0300] [Client 927] Returning IPP successful-ok for Get-Jobs (ipp://pc221@localhost:631/printers/) from localhost
D [04/Feb/2019:23:49:39 +0300] [Client 927] Content-Length: 361
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] con->http=0x55a354bed570
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=361, response=0x55a354bb7970(IPP_STATE_DATA), pipe_pid=0, file=-1
D [04/Feb/2019:23:49:39 +0300] [Client 927] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] bytes=0, http_state=0, data_remaining=361
D [04/Feb/2019:23:49:39 +0300] [Client 927] Flushing write buffer.
D [04/Feb/2019:23:49:39 +0300] [Client 927] New state is HTTP_STATE_WAITING
D [04/Feb/2019:23:49:39 +0300] [Client 927] Waiting for request.
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Notifier] state=3
D [04/Feb/2019:23:49:39 +0300] [Notifier] JobProgress
D [04/Feb/2019:23:49:39 +0300] [Client 927] POST / HTTP/1.1
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] Read: status=200, state=6
D [04/Feb/2019:23:49:39 +0300] [Client 927] No authentication data provided.
D [04/Feb/2019:23:49:39 +0300] [Client 927] 2.0 Get-Jobs 22429
D [04/Feb/2019:23:49:39 +0300] Get-Jobs ipp://pc221@localhost:631/printers/
D [04/Feb/2019:23:49:39 +0300] [Client 927] Returning IPP successful-ok for Get-Jobs (ipp://pc221@localhost:631/printers/) from localhost
D [04/Feb/2019:23:49:39 +0300] [Client 927] Content-Length: 361
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] con->http=0x55a354bed570
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=361, response=0x55a354bb40e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [04/Feb/2019:23:49:39 +0300] [Client 927] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] bytes=0, http_state=0, data_remaining=361
D [04/Feb/2019:23:49:39 +0300] [Client 927] Flushing write buffer.
D [04/Feb/2019:23:49:39 +0300] [Client 927] New state is HTTP_STATE_WAITING
D [04/Feb/2019:23:49:39 +0300] [Client 927] Waiting for request.
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] POST / HTTP/1.1
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] Read: status=200, state=6
D [04/Feb/2019:23:49:39 +0300] [Client 927] No authentication data provided.
D [04/Feb/2019:23:49:39 +0300] [Client 927] 2.0 Get-Jobs 22430
D [04/Feb/2019:23:49:39 +0300] Get-Jobs ipp://pc221@localhost:631/printers/
D [04/Feb/2019:23:49:39 +0300] [Client 927] Returning IPP successful-ok for Get-Jobs (ipp://pc221@localhost:631/printers/) from localhost
D [04/Feb/2019:23:49:39 +0300] [Client 927] Content-Length: 361
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] con->http=0x55a354bed570
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=361, response=0x55a354bb7970(IPP_STATE_DATA), pipe_pid=0, file=-1
D [04/Feb/2019:23:49:39 +0300] [Client 927] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] bytes=0, http_state=0, data_remaining=361
D [04/Feb/2019:23:49:39 +0300] [Client 927] Flushing write buffer.
D [04/Feb/2019:23:49:39 +0300] [Client 927] New state is HTTP_STATE_WAITING
D [04/Feb/2019:23:49:39 +0300] [Client 927] Waiting for request.
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Job 652] PID 17063 (/usr/lib/cups/backend/socket) exited with no errors.
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(P----)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(----S)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
E [04/Feb/2019:23:49:39 +0300] [Job 652] Job stopped due to filter errors; please consult the error_log file for details.
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(---J-)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] Discarding unused printer-state-changed event...
D [04/Feb/2019:23:49:39 +0300] cupsdMarkDirty(---J-)
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Job 652] The following messages were recorded from 23:49:37 to 23:49:37
D [04/Feb/2019:23:49:39 +0300] [Job 652] hrDeviceDesc=\"Unknown\"
D [04/Feb/2019:23:49:39 +0300] [Job 652] End of messages
D [04/Feb/2019:23:49:39 +0300] [Job 652] printer-state=3(idle)
D [04/Feb/2019:23:49:39 +0300] [Job 652] printer-state-message="Waiting for printer to finish."
D [04/Feb/2019:23:49:39 +0300] [Job 652] printer-state-reasons=none
D [04/Feb/2019:23:49:39 +0300] [Notifier] state=3
D [04/Feb/2019:23:49:39 +0300] [Notifier] JobState
D [04/Feb/2019:23:49:39 +0300] [Client 927] POST / HTTP/1.1
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] Read: status=200, state=6
D [04/Feb/2019:23:49:39 +0300] [Client 927] No authentication data provided.
D [04/Feb/2019:23:49:39 +0300] [Client 927] 2.0 Get-Jobs 22431
D [04/Feb/2019:23:49:39 +0300] Get-Jobs ipp://pc221@localhost:631/printers/
D [04/Feb/2019:23:49:39 +0300] [Client 927] Returning IPP successful-ok for Get-Jobs (ipp://pc221@localhost:631/printers/) from localhost
D [04/Feb/2019:23:49:39 +0300] [Client 927] Content-Length: 380
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] con->http=0x55a354bed570
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=380, response=0x55a354bb40e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [04/Feb/2019:23:49:39 +0300] [Client 927] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] bytes=0, http_state=0, data_remaining=380
D [04/Feb/2019:23:49:39 +0300] [Client 927] Flushing write buffer.
D [04/Feb/2019:23:49:39 +0300] [Client 927] New state is HTTP_STATE_WAITING
D [04/Feb/2019:23:49:39 +0300] [Client 927] Waiting for request.
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] POST / HTTP/1.1
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [04/Feb/2019:23:49:39 +0300] [Client 927] Read: status=200, state=6
D [04/Feb/2019:23:49:39 +0300] [Client 927] No authentication data provided.
D [04/Feb/2019:23:49:39 +0300] [Client 927] 2.0 Get-Jobs 22432
D [04/Feb/2019:23:49:39 +0300] Get-Jobs ipp://pc221@localhost:631/printers/
D [04/Feb/2019:23:49:39 +0300] [Client 927] Returning IPP successful-ok for Get-Jobs (ipp://pc221@localhost:631/printers/) from localhost
D [04/Feb/2019:23:49:39 +0300] [Client 927] Content-Length: 380
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] con->http=0x55a354bed570
D [04/Feb/2019:23:49:39 +0300] [Client 927] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=380, response=0x55a354c0c2f0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [04/Feb/2019:23:49:39 +0300] [Client 927] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [04/Feb/2019:23:49:39 +0300] [Client 927] bytes=0, http_state=0, data_remaining=380
D [04/Feb/2019:23:49:39 +0300] [Client 927] Flushing write buffer.
D [04/Feb/2019:23:49:39 +0300] [Client 927] New state is HTTP_STATE_WAITING
D [04/Feb/2019:23:49:39 +0300] [Client 927] Waiting for request.
D [04/Feb/2019:23:49:39 +0300] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
I [04/Feb/2019:23:49:40 +0300] Expiring subscriptions...
D [04/Feb/2019:23:49:40 +0300] [Job 652] Unloading...
D [04/Feb/2019:23:49:41 +0300] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"