brlaser icon indicating copy to clipboard operation
brlaser copied to clipboard

Published 20 hours ago • verified publisher icon pdewacht

Can't print to a HL-L2300D from a remote Ubuntu 20 laptop -

Open Gestas opened this issue 3 years ago • 5 comments

I have a HL-L2300D USB connected to my printer server. I can print test pages locally without an issue, I can also print from remote iOS devices via CUP's AirShare functionality. When I try and print from a remote Ubuntu 20 laptop I get a "filter failed" message on the job on the printer server and on the client the job gets stuck with ""Sending data to printer.". On both the server and client I've built brlaser from the most recent source.

Here are the debug logs from the print server for Job #163. The first error message is on line #236 - Job my-user PID 14895 (/usr/lib/cups/filter/rastertobrlaser) stopped with status 1. Any suggestions appreciated.

D [09/Sep/2020:21:50:43 +0100] [Job 163] Applying default options...
D [09/Sep/2020:21:50:43 +0100] add_job: requesting-user-name="my-user"
D [09/Sep/2020:21:50:43 +0100] Adding default job-sheets values "none,none"...
I [09/Sep/2020:21:50:43 +0100] [Job 163] Adding start banner page "none".
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [09/Sep/2020:21:50:43 +0100] [Job 163] Queued on "HL-L2300D" by "my-user".
D [09/Sep/2020:21:50:43 +0100] [Client 11] Returning IPP successful-ok for Create-Job (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:43 +0100] [Client 11] Content-Length: 209
D [09/Sep/2020:21:50:43 +0100] [Client 11] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:43 +0100] [Client 11] con->http=0x160ef68
D [09/Sep/2020:21:50:43 +0100] [Client 11] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=209, response=0x1601470(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:43 +0100] [Client 11] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:43 +0100] [Client 11] bytes=0, http_state=0, data_remaining=209
D [09/Sep/2020:21:50:43 +0100] [Client 11] Flushing write buffer.
D [09/Sep/2020:21:50:43 +0100] [Client 11] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:43 +0100] [Client 11] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] JobCreated
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 12] Server address is "192.168.1.3".
D [09/Sep/2020:21:50:43 +0100] [Client 12] Accepted from 192.168.1.136:56464 (IPv4)
D [09/Sep/2020:21:50:43 +0100] [Client 12] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] [Client 12] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 12] Read: status=200, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 12] No authentication data provided.
D [09/Sep/2020:21:50:43 +0100] [Client 12] 2.0 Get-Printer-Attributes 4
D [09/Sep/2020:21:50:43 +0100] Get-Printer-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:43 +0100] [Client 12] Returning IPP successful-ok for Get-Printer-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:43 +0100] [Client 12] Content-Length: 1831
D [09/Sep/2020:21:50:43 +0100] [Client 12] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:43 +0100] [Client 12] con->http=0x16263e0
D [09/Sep/2020:21:50:43 +0100] [Client 12] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1831, response=0x161d918(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:43 +0100] [Client 12] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:43 +0100] [Client 12] bytes=0, http_state=0, data_remaining=1831
D [09/Sep/2020:21:50:43 +0100] [Client 12] Flushing write buffer.
D [09/Sep/2020:21:50:43 +0100] [Client 12] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:43 +0100] [Client 12] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 11] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=200, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] No authentication data provided.
D [09/Sep/2020:21:50:43 +0100] [Client 11] 2.0 Send-Document 5
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 12] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 12] Read: status=200, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 12] No authentication data provided.
D [09/Sep/2020:21:50:43 +0100] [Client 12] 2.0 Get-Job-Attributes 6
D [09/Sep/2020:21:50:43 +0100] Get-Job-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:43 +0100] [Client 12] Returning IPP successful-ok for Get-Job-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:43 +0100] [Client 12] Content-Length: 270
D [09/Sep/2020:21:50:43 +0100] [Client 12] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:43 +0100] [Client 12] con->http=0x16263e0
D [09/Sep/2020:21:50:43 +0100] [Client 12] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=270, response=0x161d7b0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:43 +0100] [Client 12] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:43 +0100] [Client 12] bytes=0, http_state=0, data_remaining=270
D [09/Sep/2020:21:50:43 +0100] [Client 12] Flushing write buffer.
D [09/Sep/2020:21:50:43 +0100] [Client 12] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:43 +0100] [Client 12] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=100, state=6
D [09/Sep/2020:21:50:43 +0100] Send-Document ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:43 +0100] cupsdIsAuthorized: requesting-user-name="my-user"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [09/Sep/2020:21:50:43 +0100] [Job 163] File of type application/vnd.cups-raster queued by "my-user".
I [09/Sep/2020:21:50:43 +0100] [Job 163] Adding end banner page "none".
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Job 163] time-at-processing=1599684643
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Job 163] 1 filters for job:
D [09/Sep/2020:21:50:43 +0100] [Job 163] rastertobrlaser (application/vnd.cups-raster to printer/HL-L2300D, cost 33)
D [09/Sep/2020:21:50:43 +0100] [Job 163] job-sheets=none,none
D [09/Sep/2020:21:50:43 +0100] [Job 163] argv[0]="HL-L2300D"
D [09/Sep/2020:21:50:43 +0100] [Job 163] argv[1]="163"
D [09/Sep/2020:21:50:43 +0100] [Job 163] argv[2]="my-user"
D [09/Sep/2020:21:50:43 +0100] [Job 163] argv[3]="Test Page"
D [09/Sep/2020:21:50:43 +0100] [Job 163] argv[4]="1"
D [09/Sep/2020:21:50:43 +0100] [Job 163] argv[5]="job-uuid=urn:uuid:04ca905c-14cd-3aed-57fc-1dcf9efe78b6 job-originating-host-name=192.168.1.136 date-time-at-creation= date-time-at-processing= time-at-creation=1599684643 time-at-processing=1599684643"
D [09/Sep/2020:21:50:43 +0100] [Job 163] argv[6]="/var/spool/cups/d00163-001"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[7]="CUPS_STATEDIR=/run/cups"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[8]="HOME=/var/spool/cups/tmp"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[10]="SERVER_ADMIN=root@pi-hole"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[11]="SOFTWARE=CUPS/2.2.10"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[13]="USER=root"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[14]="CUPS_MAX_MESSAGE=2047"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[17]="IPP_PORT=631"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[18]="CHARSET=utf-8"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[19]="LANG=en_US.UTF-8"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[20]="PPD=/etc/cups/ppd/HL-L2300D.ppd"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[21]="RIP_MAX_CACHE=128m"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[22]="CONTENT_TYPE=application/vnd.cups-raster"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[23]="DEVICE_URI=usb://Brother/HL-L2300D%20series?serial=U63878G0N290064"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[24]="PRINTER_INFO=Brother HL-L2300D series"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[25]="PRINTER_LOCATION="
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[26]="PRINTER=HL-L2300D"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[27]="PRINTER_STATE_REASONS=none"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[28]="CUPS_FILETYPE=document"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[29]="FINAL_CONTENT_TYPE=printer/HL-L2300D"
D [09/Sep/2020:21:50:43 +0100] [Job 163] envp[30]="AUTH_I****"
I [09/Sep/2020:21:50:43 +0100] [Job 163] Started filter /usr/lib/cups/filter/rastertobrlaser (PID 14895)
I [09/Sep/2020:21:50:43 +0100] [Job 163] Started backend /usr/lib/cups/backend/usb (PID 14896)
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 11] Returning IPP successful-ok for Send-Document (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:43 +0100] [Client 11] Content-Length: 179
D [09/Sep/2020:21:50:43 +0100] [Client 11] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:43 +0100] [Client 11] con->http=0x160ef68
D [09/Sep/2020:21:50:43 +0100] [Client 11] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=179, response=0x161f0c8(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:43 +0100] [Client 11] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:43 +0100] [Client 11] bytes=0, http_state=0, data_remaining=179
D [09/Sep/2020:21:50:43 +0100] [Client 11] Flushing write buffer.
D [09/Sep/2020:21:50:43 +0100] [Client 11] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:43 +0100] [Client 11] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] PrinterStateChanged
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] JobState
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Client 11] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 11] Read: status=200, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 11] No authentication data provided.
D [09/Sep/2020:21:50:43 +0100] [Client 11] 2.0 Get-Printer-Attributes 7
D [09/Sep/2020:21:50:43 +0100] Get-Printer-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:43 +0100] [Client 11] Returning IPP successful-ok for Get-Printer-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:43 +0100] [Client 11] Content-Length: 1831
D [09/Sep/2020:21:50:43 +0100] [Client 11] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:43 +0100] [Client 11] con->http=0x160ef68
D [09/Sep/2020:21:50:43 +0100] [Client 11] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1831, response=0x161f110(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:43 +0100] [Client 11] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:43 +0100] [Client 11] bytes=0, http_state=0, data_remaining=1831
D [09/Sep/2020:21:50:43 +0100] [Client 11] Flushing write buffer.
D [09/Sep/2020:21:50:43 +0100] [Client 11] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:43 +0100] [Client 11] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 11] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [09/Sep/2020:21:50:43 +0100] [Client 11] Closing connection.
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 13] Server address is "192.168.1.3".
D [09/Sep/2020:21:50:43 +0100] [Client 13] Accepted from 192.168.1.136:56466 (IPv4)
D [09/Sep/2020:21:50:43 +0100] [Client 13] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] [Client 13] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Client 13] Read: status=200, state=6
D [09/Sep/2020:21:50:43 +0100] [Client 13] No authentication data provided.
D [09/Sep/2020:21:50:43 +0100] [Client 13] 2.0 Get-Job-Attributes 8
D [09/Sep/2020:21:50:43 +0100] Get-Job-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:43 +0100] [Client 13] Returning IPP successful-ok for Get-Job-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:43 +0100] [Client 13] Content-Length: 270
D [09/Sep/2020:21:50:43 +0100] [Client 13] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:43 +0100] [Client 13] con->http=0x160ef68
D [09/Sep/2020:21:50:43 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=270, response=0x161de48(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:43 +0100] [Client 13] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:43 +0100] [Client 13] bytes=0, http_state=0, data_remaining=270
D [09/Sep/2020:21:50:43 +0100] [Client 13] Flushing write buffer.
D [09/Sep/2020:21:50:43 +0100] [Client 13] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:43 +0100] [Client 13] Waiting for request.
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Job 163] brlaser version 6
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Job 163] Set job-printer-state-message to "brlaser version 6", current level=INFO
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Job 163] PID 14895 (/usr/lib/cups/filter/rastertobrlaser) stopped with status 1.
D [09/Sep/2020:21:50:43 +0100] [Job 163] brlaser: Cannot read raster data. Most likely an earlier filter in the pipeline failed.
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] JobProgress
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] PrinterStateChanged
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Job 163] Loading USB quirks from \"/usr/share/cups/usb\".
D [09/Sep/2020:21:50:43 +0100] [Job 163] Loaded 172 quirks.
D [09/Sep/2020:21:50:43 +0100] [Job 163] Printing on printer with URI: usb://Brother/HL-L2300D%20series?serial=U63878G0N290064
D [09/Sep/2020:21:50:43 +0100] [Job 163] libusb_get_device_list=5
D [09/Sep/2020:21:50:43 +0100] [Job 163] STATE: +connecting-to-device
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:43 +0100] [Job 163] STATE: -connecting-to-device
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] PrinterStateChanged
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] PrinterStateChanged
D [09/Sep/2020:21:50:43 +0100] [Job 163] Device protocol: 2
D [09/Sep/2020:21:50:43 +0100] [Job 163] Sending data to printer.
D [09/Sep/2020:21:50:43 +0100] [Job 163] Sent 0 bytes...
D [09/Sep/2020:21:50:43 +0100] [Job 163] Waiting for read thread to exit...
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] JobProgress
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] PrinterStateChanged
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Job 163] PID 14896 (/usr/lib/cups/backend/usb) exited with no errors.
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
E [09/Sep/2020:21:50:43 +0100] [Job 163] Job stopped due to filter errors; please consult the /var/log/cups/error_log file for details.
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(---J-)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] cupsdMarkDirty(----S)
D [09/Sep/2020:21:50:43 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:43 +0100] [Job 163] The following messages were recorded from 21:50:43 to 21:50:43
D [09/Sep/2020:21:50:43 +0100] [Job 163] Printer found with device ID: MFG:Brother;CMD:PJL,HBP;MDL:HL-L2300D series;CLS:PRINTER;CID:Brother Laser Type1; Device URI: usb://Brother/HL-L2300D%20series?serial=U63878G0N290064
D [09/Sep/2020:21:50:43 +0100] [Job 163] End of messages
D [09/Sep/2020:21:50:43 +0100] [Job 163] printer-state=3(idle)
D [09/Sep/2020:21:50:43 +0100] [Job 163] printer-state-message="Sending data to printer."
D [09/Sep/2020:21:50:43 +0100] [Job 163] printer-state-reasons=none
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] JobState
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] PrinterStateChanged
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:43 +0100] [Notifier] state=3
D [09/Sep/2020:21:50:44 +0100] [Client 12] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 12] Read: status=200, state=6
D [09/Sep/2020:21:50:44 +0100] [Client 12] No authentication data provided.
D [09/Sep/2020:21:50:44 +0100] [Client 12] 2.0 Get-Printer-Attributes 9
D [09/Sep/2020:21:50:44 +0100] Get-Printer-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:44 +0100] [Client 12] Returning IPP successful-ok for Get-Printer-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:44 +0100] [Client 12] Content-Length: 1855
D [09/Sep/2020:21:50:44 +0100] [Client 12] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
I [09/Sep/2020:21:50:44 +0100] Expiring subscriptions...
D [09/Sep/2020:21:50:44 +0100] [Job 163] Unloading...
D [09/Sep/2020:21:50:44 +0100] [Client 12] con->http=0x16263e0
D [09/Sep/2020:21:50:44 +0100] [Client 12] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1855, response=0x1630550(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:44 +0100] [Client 12] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:44 +0100] [Client 12] bytes=0, http_state=0, data_remaining=1855
D [09/Sep/2020:21:50:44 +0100] [Client 12] Flushing write buffer.
D [09/Sep/2020:21:50:44 +0100] [Client 12] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:44 +0100] [Client 12] Waiting for request.
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 12] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 12] Read: status=200, state=6
D [09/Sep/2020:21:50:44 +0100] [Client 12] No authentication data provided.
D [09/Sep/2020:21:50:44 +0100] [Client 12] 2.0 Get-Job-Attributes 10
D [09/Sep/2020:21:50:44 +0100] Get-Job-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:44 +0100] [Job 163] Loading attributes...
D [09/Sep/2020:21:50:44 +0100] [Client 12] Returning IPP successful-ok for Get-Job-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:44 +0100] [Client 12] Content-Length: 283
D [09/Sep/2020:21:50:44 +0100] [Client 12] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:44 +0100] [Client 12] con->http=0x16263e0
D [09/Sep/2020:21:50:44 +0100] [Client 12] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=283, response=0x161b418(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:44 +0100] [Client 12] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:44 +0100] [Client 12] bytes=0, http_state=0, data_remaining=283
D [09/Sep/2020:21:50:44 +0100] [Client 12] Flushing write buffer.
D [09/Sep/2020:21:50:44 +0100] [Client 12] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:44 +0100] [Client 12] Waiting for request.
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 13] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 13] Read: status=200, state=6
D [09/Sep/2020:21:50:44 +0100] [Client 13] No authentication data provided.
D [09/Sep/2020:21:50:44 +0100] [Client 13] 2.0 Get-Printer-Attributes 11
D [09/Sep/2020:21:50:44 +0100] Get-Printer-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:44 +0100] [Client 13] Returning IPP successful-ok for Get-Printer-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:44 +0100] [Client 13] Content-Length: 1855
D [09/Sep/2020:21:50:44 +0100] [Client 13] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:44 +0100] [Client 13] con->http=0x160ef68
D [09/Sep/2020:21:50:44 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1855, response=0x1630408(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:44 +0100] [Client 13] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:44 +0100] [Client 13] bytes=0, http_state=0, data_remaining=1855
D [09/Sep/2020:21:50:44 +0100] [Client 13] Flushing write buffer.
D [09/Sep/2020:21:50:44 +0100] [Client 13] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:44 +0100] [Client 13] Waiting for request.
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 13] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [09/Sep/2020:21:50:44 +0100] [Client 13] Closing connection.
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 14] Server address is "192.168.1.3".
D [09/Sep/2020:21:50:44 +0100] [Client 14] Accepted from 192.168.1.136:56470 (IPv4)
D [09/Sep/2020:21:50:44 +0100] [Client 14] Waiting for request.
D [09/Sep/2020:21:50:44 +0100] [Client 14] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:44 +0100] [Client 14] Read: status=200, state=6
D [09/Sep/2020:21:50:44 +0100] [Client 14] No authentication data provided.
D [09/Sep/2020:21:50:44 +0100] [Client 14] 2.0 Get-Job-Attributes 12
D [09/Sep/2020:21:50:44 +0100] Get-Job-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:44 +0100] [Client 14] Returning IPP successful-ok for Get-Job-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:44 +0100] [Client 14] Content-Length: 283
D [09/Sep/2020:21:50:44 +0100] [Client 14] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [09/Sep/2020:21:50:44 +0100] [Client 14] con->http=0x160dde8
D [09/Sep/2020:21:50:44 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=283, response=0x161b418(IPP_STATE_DATA), pipe_pid=0, file=-1
D [09/Sep/2020:21:50:44 +0100] [Client 14] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [09/Sep/2020:21:50:44 +0100] [Client 14] bytes=0, http_state=0, data_remaining=283
D [09/Sep/2020:21:50:44 +0100] [Client 14] Flushing write buffer.
D [09/Sep/2020:21:50:44 +0100] [Client 14] New state is HTTP_STATE_WAITING
D [09/Sep/2020:21:50:44 +0100] [Client 14] Waiting for request.
D [09/Sep/2020:21:50:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [09/Sep/2020:21:50:45 +0100] [Client 12] POST /printers/HL-L2300D HTTP/1.1
D [09/Sep/2020:21:50:45 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [09/Sep/2020:21:50:45 +0100] [Client 12] Read: status=200, state=6
D [09/Sep/2020:21:50:45 +0100] [Client 12] No authentication data provided.
D [09/Sep/2020:21:50:45 +0100] [Client 12] 2.0 Get-Printer-Attributes 13
D [09/Sep/2020:21:50:45 +0100] Get-Printer-Attributes ipp://pi-hole.local:631/printers/HL-L2300D
D [09/Sep/2020:21:50:45 +0100] [Client 12] Returning IPP successful-ok for Get-Printer-Attributes (ipp://pi-hole.local:631/printers/HL-L2300D) from 192.168.1.136.
D [09/Sep/2020:21:50:45 +0100] [Client 12] Content-Length: 1855
D [09/Sep/2020:21:50:45 +0100] [Client 12] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
I [09/Sep/2020:21:50:45 +0100] Expiring subscriptions...
D [09/Sep/2020:21:50:45 +0100] [Client 12] con->http=0x16263e0
D [09/Sep/2020:21:50:45 +0100] [Client 12] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND,

Gestas avatar Sep 09 '20 21:09 Gestas

You probably just need to add it as a Generic Postscript Printer (or similar) from the remote computer (the remote computer doesn't need to use the brlaser driver).

cozzyd avatar Dec 03 '20 00:12 cozzyd

I had the same problem with macOS and a Brother HL-L2340DW. I fixed it by deleting the printer, adding it from the Printer system preference panel, selecting the auto detected printer name, but in the "Use" box of the printer add dialog selecting "Generic Postscript Printer" in place of the default brlaser driver. Thanks @cozzyd !

robbuckley avatar Jan 10 '21 20:01 robbuckley

@robbuckley can you confirm that the Brother HL-L2340DW works with Brlaser ?

zeroheure avatar Jan 06 '22 16:01 zeroheure

If it's Generic Postscript Printer how do I set Toner save mode and other settings?

tigerinus avatar Jan 07 '22 22:01 tigerinus

@tigerinus Generic Postscript Printer is not related to this project. Only generic options are available, Toner save mode is not. But it is often possible to set it directly on the printer as the default mode. You may also try one of the Generic PCL printers.

zeroheure avatar Jan 08 '22 14:01 zeroheure