Brother laser printer does not print / scanner not recognised

English Hardware
1

I installed A new Brother DCP1610W laser printer (combined with scanner). It is connected by USB to my desktop, running openSUSE 15.3 .

The installation was smooth, using the driver and CUPS wrapper from the Brother site. In YaST it appears “ready”, but when I send a test page over it does not print. The print job appears as “active” on the queue but nothing prints. When I click the “printing test page failed” botton I get this:

printer DCP1610W now printing DCP1610W-21. enabled since Fri Dec 10 20:11:50 2021
Waiting for printer to become available.

The last few lines in /var/log/cops/error_log are:

[FONT=monospace]E [10/Dec/2021:20:05:03 +0000] [cups-deviced] PID 3508 (gutenprint52+usb) stopped with status 1!
E [10/Dec/2021:20:05:03 +0000] [CGI] cups-brf must be called as root
E [10/Dec/2021:20:05:03 +0000] [cups-deviced] PID 3512 (cups-brf) stopped with status 1!
W [10/Dec/2021:20:07:27 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The
name org.freedesktop.ColorManager was not provided by any .service files
W [10/Dec/2021:20:07:27 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files

I have also installed the scanner drivers from Brother, but YaST does not detect any scanner.

I have never had this problem before with other printers. Any advice would be welcome.

[/FONT]

2

Brother driver are 32 bit, so you have to install the 32 bit packages:

zypper in -f glibc-32bit libusb-0_1-4-32bit libusb-1_0-0-32bit
3

Thanks for the advice. I would never have guessed that Brother drivers are so primitive.

However, the problem persists: I installed the 32-bit packages as suggested, then re-installed the printer, using the installer code supplied by Brother. Still nothing prints.

/var/log/cups/error_log now contains these lines:

E [10/Dec/2021:21:16:42 +0000] [CGI] cups-brf must be called as root
E [10/Dec/2021:21:16:42 +0000] [cups-deviced] PID 3657 (cups-brf) stopped with status 1!
E [10/Dec/2021:21:16:42 +0000] [cups-deviced] PID 3653 (gutenprint52+usb) stopped with status 1!
E [10/Dec/2021:21:16:48 +0000] [cups-driverd] Bad driver information file “/usr/share/cups/drv/generic-brf.drv”!
E [10/Dec/2021:21:16:48 +0000] [cups-driverd] Bad driver information file “/usr/share/cups/drv/cupsfilters.drv”!
E [10/Dec/2021:21:16:48 +0000] [cups-driverd] Bad driver information file “/usr/share/cups/drv/indexv3.drv”!
E [10/Dec/2021:21:16:48 +0000] [cups-driverd] Bad driver information file “/usr/share/cups/drv/sample.drv”!
E [10/Dec/2021:21:16:48 +0000] [cups-driverd] Bad driver information file “/usr/share/cups/drv/generic-ubrl.drv”!
E [10/Dec/2021:21:16:48 +0000] [cups-driverd] Bad driver information file “/usr/share/cups/drv/indexv4.drv”!
E [10/Dec/2021:21:17:44 +0000] [CGI] cups-brf must be called as root
E [10/Dec/2021:21:17:44 +0000] [cups-deviced] PID 17800 (cups-brf) stopped with status 1!
E [10/Dec/2021:21:17:44 +0000] [cups-deviced] PID 17795 (gutenprint52+usb) stopped with status 1!
E [10/Dec/2021:21:18:37 +0000] [CGI] cups-brf must be called as root
E [10/Dec/2021:21:18:37 +0000] [cups-deviced] PID 18015 (cups-brf) stopped with status 1!
E [10/Dec/2021:21:18:37 +0000] [cups-deviced] PID 18011 (gutenprint52+usb) stopped with status 1!
W [10/Dec/2021:21:18:41 +0000] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
W [10/Dec/2021:21:18:41 +0000] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files

Have I missed something?

4

Clear the existing CUPS error log

sudo rm -f /var/log/cups/error_log

Put CUPS into debug mode (more verbose logging)

sudo cupsctl --debug-logging

Attempt to print a test page, document, or image, and capture any filter-related messages or errors…

egrep -iaA4 "filter|error" /var/log/cups/error_log

Report back here with the captured output.

5

Thanks. Captured output is very long. It was 56975 chars long and I can’t send attachments. So here is the tail end of it:

[FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace]
[/FONT][/FONT][/FONT][/FONT][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace]
D [10/Dec/2021:21:59:50 +0000] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_
SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=8531, response=0x55b293355760(IPP_STATE_DA
TA), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 14] Writing IPP response, ipp_state=IPP_STATE_DATA, old wuse
d=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 14] bytes=0, http_state=0, data_remaining=8531
D [10/Dec/2021:21:59:50 +0000] [Client 14] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 14] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_
SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=197, response=0x55b2933556d0(IPP_STATE_IDL
E), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 14] Writing IPP response, ipp_state=IPP_STATE_DATA, old wuse
d=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 14] bytes=0, http_state=0, data_remaining=197
D [10/Dec/2021:21:59:50 +0000] [Client 14] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 14] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Job 25] 3 filters for job:
D [10/Dec/2021:21:59:50 +0000] [Job 25] gstopdf (application/postscript to application/pdf, cost 0)
D [10/Dec/2021:21:59:50 +0000] [Job 25] pdftopdf (application/pdf to application/vnd.cups-pdf, cost
66)
D [10/Dec/2021:21:59:50 +0000] [Job 25] brother_lpdwrapper_DCP1610W (application/vnd.cups-pdf to pr
inter/DCP1610W, cost 0)
D [10/Dec/2021:21:59:50 +0000] [Job 25] job-sheets=none,none

D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[9]=“PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:
/usr/bin”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[10]=“SERVER_ADMIN=root@nina”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[11]=“SOFTWARE=CUPS/2.2.7”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[12]=“TMPDIR=/var/spool/cups/tmp”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[13]=“USER=root”

[/FONT][/FONT][/FONT][/FONT][/FONT]
[FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace]I [10/Dec/2021:21:59:50 +0000] [Job 25] Started filter /usr/lib/cups/filter/gstopdf (PID 20784)
I [10/Dec/2021:21:59:50 +0000] [Job 25] Started filter /usr/lib/cups/filter/pdftopdf (PID 20785)
I [10/Dec/2021:21:59:50 +0000] [Job 25] Started filter /usr/lib/cups/filter/brother_lpdwrapper_DCP1
610W (PID 20786)
I [10/Dec/2021:21:59:50 +0000] [Job 25] Started backend /usr/lib/cups/backend/usb (PID 20787)
D [10/Dec/2021:21:59:50 +0000] cupsdMarkDirty(----S)
D [10/Dec/2021:21:59:50 +0000] cupsdSetBusyState: newbusy=“Active clients, printing jobs, and dirty
files”, busy=“Active clients and dirty files”
D [10/Dec/2021:21:59:50 +0000] [Client 14] Returning IPP successful-ok for Send-Document (ipp://loc
alhost:631/printers/DCP1610W) from localhost

D [10/Dec/2021:21:59:50 +0000] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_
SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=167, response=0x55b29334d620(IPP_STATE_DAT
A), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 14] Writing IPP response, ipp_state=IPP_STATE_DATA, old wuse
d=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 14] bytes=0, http_state=0, data_remaining=167
D [10/Dec/2021:21:59:50 +0000] [Client 14] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 14] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 14] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [10/Dec/2021:21:59:50 +0000] [Client 14] Closing connection.
D [10/Dec/2021:21:59:50 +0000] cupsdSetBusyState: newbusy=“Printing jobs and dirty files”, busy=“Pr
inting jobs and dirty files”
D [10/Dec/2021:21:59:50 +0000] [Job 25] gstopdf argv[6] = 25 root YaST2testprint_DCP1610W 1 finishi
ngs=3 number-up=1 page-label=DCP1610W:YaST2testprint@nina job-uuid=urn:uuid:ad797a55-7488-302c-6c17
-a5e54440b55d job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= t
ime-at-creation=1639173590 time-at-processing=1639173590 document-name-supplied=testprint.ps /var/s
pool/cups/d00025-001
D [10/Dec/2021:21:59:50 +0000] [Job 25] PPD: /etc/cups/ppd/DCP1610W.ppd

D [10/Dec/2021:21:59:50 +0000] [Job 25] pdftopdf: Last filter determined by the PPD: brother_lpdwra
pper_DCP1610W; FINAL_CONTENT_TYPE: application/vnd.cups-pdf => pdftopdf will not log pages in page_
log.
D [10/Dec/2021:21:59:50 +0000] [Job 25] Loaded 161 quirks.
D [10/Dec/2021:21:59:50 +0000] [Job 25] Printing on printer with URI: usb://dev/usb/lp0
D [10/Dec/2021:21:59:50 +0000] [Job 25] Color Manager: Calibration Mode/Off
D [10/Dec/2021:21:59:50 +0000] [Job 25] Calling FindDeviceById(cups-DCP1610W)
D [10/Dec/2021:21:59:50 +0000] [Job 25] Failed to send: org.freedesktop.DBus.Error.ServiceUnknown:T
he name org.freedesktop.ColorManager was not provided by any .service files
D [10/Dec/2021:21:59:50 +0000] [Job 25] Failed to get find device cups-DCP1610W
D [10/Dec/2021:21:59:50 +0000] [Job 25] Calling FindDeviceById(cups-DCP1610W)
D [10/Dec/2021:21:59:50 +0000] [Job 25] Failed to send: org.freedesktop.DBus.Error.ServiceUnknown:T
he name org.freedesktop.ColorManager was not provided by any .service files
D [10/Dec/2021:21:59:50 +0000] [Job 25] Failed to get device cups-DCP1610W
D [10/Dec/2021:21:59:50 +0000] [Job 25] Color Manager: no profiles specified in PPD
D [10/Dec/2021:21:59:50 +0000] cupsdMarkDirty(—J-)
D [10/Dec/2021:21:59:50 +0000] cupsdSetBusyState: newbusy=“Printing jobs and dirty files”, busy=“Pr
inting jobs and dirty files”

[/FONT][/FONT][/FONT][/FONT][/FONT][/FONT]
[FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace]D [10/Dec/2021:21:59:50 +0000] [Job 25] Ghostscript command line: gs -dQUIET -dPARANOIDSAFER -dNOPA
USE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=pdfwrite
-dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false -dNOPLATFONTS -dColo
rImageFilter=/FlateEncode -dPDFSETTINGS=/printer -dColorConversionStrategy=/LeaveColorUnchanged -r6
00x600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -I/usr/share/cups/fonts -c ‘<</.HWMargins
12.000000 12.000000 12.000000 12.000000] /Margins[0 0]>>setpagedevice’ -f -_
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[0]=“OUTFORMAT=PDF”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[1]=“CUPS_DOCROOT=/usr/share/cups/webcontent”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[2]=“CUPS_CACHEDIR=/var/cache/cups”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[3]=“LANG=en.UTF-8”

D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[31]=“PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bi
n:/usr/bin”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[32]=“AUTH_INFO_REQUIRED=none”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[33]=“PRINTER_STATE_REASONS=none”
D [10/Dec/2021:21:59:50 +0000] [Job 25] envp[34]="_=/usr/lib/cups/filter/gstoraster"
D [10/Dec/2021:21:59:50 +0000] [Notifier] state=3
D [10/Dec/2021:21:59:50 +0000] [Notifier] JobProgress
D [10/Dec/2021:21:59:50 +0000] [Notifier] state=3
D [10/Dec/2021:21:59:50 +0000] [Notifier] PrinterStateChanged

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=452, response=0x55b2933623f0(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=452
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=452, response=0x55b29334d210(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=452
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=460, response=0x55b2933640f0(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=460
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=460, response=0x55b29334d210(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=460
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=460, response=0x55b2933640f0(IPP_STATE_DATA
), pipe_pid=0, file=-1
[/FONT][/FONT][/FONT][/FONT][/FONT][/FONT][/FONT]
[FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace]D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=460
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=460, response=0x55b29334d210(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=460
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=457, response=0x55b293342ad0(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=457
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=449, response=0x55b2933623f0(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=449
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=449, response=0x55b293342ad0(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=449
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Client 1] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_S
END, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=457, response=0x55b293360100(IPP_STATE_DATA
), pipe_pid=0, file=-1
D [10/Dec/2021:21:59:50 +0000] [Client 1] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused
=0, new wused=0
D [10/Dec/2021:21:59:50 +0000] [Client 1] bytes=0, http_state=0, data_remaining=457
D [10/Dec/2021:21:59:50 +0000] [Client 1] Flushing write buffer.
D [10/Dec/2021:21:59:50 +0000] [Client 1] New state is HTTP_STATE_WAITING

D [10/Dec/2021:21:59:50 +0000] [Job 25] PID 20784 (/usr/lib/cups/filter/gstopdf) exited with no err
ors.
[/FONT][/FONT][/FONT][/FONT][/FONT][/FONT][/FONT][/FONT]
[FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace][FONT=monospace]D [10/Dec/2021:21:59:50 +0000] [Job 25] PDF interactive form and annotation flattening done via QPD
F
D [10/Dec/2021:21:59:50 +0000] [Job 25] PID 20785 (/usr/lib/cups/filter/pdftopdf) exited with no er
rors.
I [10/Dec/2021:21:59:51 +0000] Expiring subscriptions…
I [10/Dec/2021:21:59:53 +0000] Saving job.cache…
I [10/Dec/2021:21:59:53 +0000] Saving subscriptions.conf…
D [10/Dec/2021:21:59:53 +0000] cupsdSetBusyState: newbusy=“Printing jobs”, busy=“Printing jobs and
dirty files”

[/FONT][/FONT][/FONT][/FONT]
[/FONT][/FONT]=0
[/FONT]
[/FONT]
[/FONT]

6

For lengthy output, use susepaste…
https://paste.opensuse.org/

There is a ‘susepaste’ command (package of the same name) which can also be used to upload files as well.

7

For ease of reading, I’ve consolidated the output you shared to show relevant info…

D [10/Dec/2021:21:59:50 +0000] [Job 25] 3 filters for job: 
D [10/Dec/2021:21:59:50 +0000] [Job 25] gstopdf (application/postscript to application/pdf, cost 0) 
D [10/Dec/2021:21:59:50 +0000] [Job 25] pdftopdf (application/pdf to application/vnd.cups-pdf, cost
 66) 
D [10/Dec/2021:21:59:50 +0000] [Job 25] brother_lpdwrapper_DCP1610W (application/vnd.cups-pdf to pr
inter/DCP1610W, cost 0)

The above shows the filter chain used to process the print job.

No apparent filter errors reported…

D [10/Dec/2021:21:59:50 +0000] [Job 25] PID 20784 (/usr/lib/cups/filter/gstopdf) exited with no err
ors.

D [10/Dec/2021:21:59:50 +0000] [Job 25] PDF interactive form and annotation flattening done via QPD
F 
D [10/Dec/2021:21:59:50 +0000] [Job 25] PID 20785 (/usr/lib/cups/filter/pdftopdf) exited with no er
rors.
8

I learn as I go along:

https://paste.opensuse.org/53232479

9

Please share

lpstat -t

and

lpq -P DCP1610W
10

lpstat -t gives:


scheduler is running 
no system default destination 
device for DCP1610W: usb://dev/usb/lp0 
DCP1610W accepting requests since Fri 10 Dec 2021 21:59:50 GMT 
printer DCP1610W now printing DCP1610W-25.  enabled since Fri 10 Dec 2021 21:59:50 GMT 
        Waiting for printer to become available. 
DCP1610W-25             root             17408   Fri 10 Dec 2021 21:59:50 GMT

[FONT=monospace]

lpq -PDCP1610W shows the pending job on the queue:
[/FONT]


DCP1610W is ready and printing 
Rank    Owner   Job     File(s)                         Total Size 
active  root    25      YaST2testprint_DCP1610W         17408 bytes
11

That printer URI doesn’t look right.

For comparison, my USB-connected DCP-7055 printer is reported like this

dean@linux-4k1z:/> lpstat -t
scheduler is running
no system default destination
device for DCP7055: usb://Brother/DCP-7055?serial=E69893D1N337394
DCP7055 accepting requests since Sat 11 Dec 2021 11:33:49 NZDT
printer DCP7055 is idle.  enabled since Sat 11 Dec 2021 11:33:49 NZDT

Delete your exiting printer configuration. Use the CUPS web interface to configure using your favourite browser. Navigate to ‘localhost:631/admin’ and configure from there.

lpq -PDCP1610W shows the pending job on the queue:

DCP1610W is ready and printing
Rank Owner Job File(s) Total Size
active root 25 YaST2testprint_DCP1610W 17408 bytes

You can cancel any pending jobs with

sudo cancel -a
12

I cancelled the configuration in YaST and added the printer in CUPS. I then requested CUPS to print a test page. Still nothing.

On the plus side, lpstat -t now reads similar to the output you shared:


scheduler is running 
no system default destination 
device for DCP1610W: lpd://nina/DCP1610W 
DCP1610W accepting requests since Fri 10 Dec 2021 23:04:36 GMT 
printer DCP1610W now printing DCP1610W-26.  enabled since Fri 10 Dec 2021 23:04:36 GMT 
        The printer is in use. 
DCP1610W-26             root              1024   Fri 10 Dec 2021 23:04:36 GMT
13

Is your printer USB-connected or network (wired or wifi) connected?

What is reported via the following command?

sudo lpinfo -vv
14

The printer is connected by a USB cable.

Output of lpinfo -vv is:


network ipp 
network beh 
network lpd 
network http 
network socket 
network https 
network ipps 
network smb 
network ipp 
network lpd 
network beh 
network https 
network http 
network ipps 
network socket 
network smb
15

Then the URI should be more like

usb://Brother/DCP1610W

I would have expected it to be reported by lpinfo (as a directly-connected device).

16

Related Brother FAQ:
https://support.brother.com/g/b/faqend.aspx?c=gb&lang=en&prod=dcp1610w_eu_as&faqid=faq00100675_000

17

So this suggests that the usb cable itself is defective. I’ll order a replacement.

I just need to understand this point: is the entire installation process that I undertook done on the computer side, without actually verifying that the installed printer can be contacted? If not, the cable must be operational. This is rather confusing.

Thanks for the help. If the new cable does not solve the problem I will contact Brother.

Abe

18

We can check…

With the printer turned on but disconnected, open a terminal and do

sudo dmesg -w

Now plug in the USB cable and observe any output generated.

USB-connected devices should be enumerated…

lsusb

I just need to understand this point: is the entire installation process that I undertook done on the computer side, without actually verifying that the installed printer can be contacted? If not, the cable must be operational. This is rather confusing.

The driver installation and CUPS configuration can be done without the printer being available (ie not connected or turned on). However, USB-connected devices should be detected and reported by CUPS automatically. From what you’ve inferred, this did not happen?

19

You should be able to attach to your network via front panel configuration? Have you tried that already?

20

The messages generated after the cable was reconnected are interesting:


[10060.905915] usb 3-3: new high-speed USB device number 14 using ehci-pci 
[10061.033916] usb 3-3: device descriptor read/64, error -32
[10061.269901] usb 3-3: device descriptor read/64, error -32
[10061.505906] usb 3-3: new high-speed USB device number 15 using ehci-pci 
[10061.633845] usb 3-3: device descriptor read/64, error -32
[10061.869892] usb 3-3: device descriptor read/64, error -32
[10061.977969] usb usb3-port3: attempt power cycle 
[10062.181926] usb 3-3: new high-speed USB device number 16 using ehci-pci 
[10062.597915] usb 3-3: device not accepting address 16, error -32
[10062.729912] usb 3-3: new high-speed USB device number 17 using ehci-pci 
[10063.145909] usb 3-3: device not accepting address 17, error -32
[10063.145943] usb usb3-port3: unable to enumerate USB device
[10063.505872] usb 9-3: new full-speed USB device number 14 using ohci-pci 
[10063.673881] usb 9-3: device descriptor read/64, error -32
[10063.945922] usb 9-3: device descriptor read/64, error -32
[10064.213916] usb 9-3: new full-speed USB device number 15 using ohci-pci 
[10064.373913] usb 9-3: device descriptor read/64, error -32
[10064.645925] usb 9-3: device descriptor read/64, error -32
[10064.753953] usb usb9-port3: attempt power cycle 
[10064.937912] usb 9-3: new full-speed USB device number 16 using ohci-pci 
[10065.353904] usb 9-3: device not accepting address 16, error -32
[10065.509915] usb 9-3: new full-speed USB device number 17 using ohci-pci 
[10065.925909] usb 9-3: device not accepting address 17, error -32
[10065.925955] usb usb9-port3: unable to enumerate USB device

I then disconnected the cable from the pc and reconnected it on a different USB port. The output is different now:



[FONT=monospace][10316.837398] usb 5-1.3: new high-speed USB device number 5 using xhci_hcd 
[10316.938488] usb 5-1.3: New USB device found, idVendor=04f9, idProduct=035b, bcdDevice= 1.00 
[10316.938493] usb 5-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 
[10316.938496] usb 5-1.3: Product: DCP-1610W 
[10316.938499] usb 5-1.3: Manufacturer: Brother 
[10316.938501] usb 5-1.3: SerialNumber: E74225H1N882595 
[10317.040566] usblp 5-1.3:1.0: usblp0: USB Bidirectional printer dev 5 if 0 alt 0 proto 2 vid 0x04
F9 pid 0x035B 
[10317.040587] usbcore: registered new interface driver usblp 
[10322.132431] usblp0: removed 
[10322.139224] usblp 5-1.3:1.0: usblp0: USB Bidirectional printer dev 5 if 0 alt 0 proto 2 vid 0x04
F9 pid 0x035B
[/FONT]

[FONT=monospace]

I don’t understand the “usblp0: removed” towards the end. At any rate, a fresh attempt to print the test page did not succeed.

I have not tried connecting it to a wifi network because there isn’t one active in my house (long story).

[/FONT]