Problem, maybe because of update, with Brother HL2140

Sun Apr 19 05:49:13 PDT 2009

Hello!

I have Debian Linux with current testing-branch cups packet (1.3.10).
I have a Brother HL2140 USB Laser Printer and did install it correctly with the information from Brother. It worked for about half a year, last time I printed was middle of march this year. I did not change anything except some updates, but I don't really know if my cups was upgraded. First time where this problem occured was version 1.3.9.

Problem is the following:
I can queue print jobs as normal, they get processed without error and then they are just "done". But my printer does not print anything! He comes out of sleep mode and warms up, but does not print anything.

Exactly the same problem when I connect it to my Windows machine and try to print over samba. Under Windows directly I can print, so the printer should be fine.

Debug log:
D [19/Apr/2009:14:36:40 +0200] cupsdReadClient: 8 GET /printers/BrotherHL2140Win?op=print-test-page HTTP/1.1
D [19/Apr/2009:14:36:40 +0200] cupsdAuthorize: Authorized as root using Basic
D [19/Apr/2009:14:36:40 +0200] [CGI] /usr/lib/cups/cgi-bin/printers.cgi started - PID = 12276
I [19/Apr/2009:14:36:40 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=12276)
D [19/Apr/2009:14:36:40 +0200] cupsdSendCommand: 8 file=9
D [19/Apr/2009:14:36:40 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [19/Apr/2009:14:36:40 +0200] cupsdReadClient: 11 POST /printers/BrotherHL2140Win HTTP/1.1
D [19/Apr/2009:14:36:40 +0200] cupsdAuthorize: No authentication data provided.
D [19/Apr/2009:14:36:40 +0200] Print-Job ipp://localhost:631/printers/BrotherHL2140Win
E [19/Apr/2009:14:36:40 +0200] Print-Job: Unauthorized
D [19/Apr/2009:14:36:40 +0200] cupsdSendError: 11 code=401 (Unauthorized)
D [19/Apr/2009:14:36:40 +0200] cupsdSendHeader: WWW-Authenticate: Basic realm="CUPS"
D [19/Apr/2009:14:36:40 +0200] cupsdAcceptClient: 12 from localhost (Domain)
D [19/Apr/2009:14:36:40 +0200] cupsdCloseClient: 11
D [19/Apr/2009:14:36:40 +0200] cupsdReadClient: 12 POST /printers/BrotherHL2140Win HTTP/1.1
D [19/Apr/2009:14:36:40 +0200] cupsdAuthorize: Authorized as root using Local
D [19/Apr/2009:14:36:40 +0200] Print-Job ipp://localhost:631/printers/BrotherHL2140Win
D [19/Apr/2009:14:36:40 +0200] Adding default job-sheets values "none,none"...
I [19/Apr/2009:14:36:40 +0200] [Job 131] Adding start banner page "none".
D [19/Apr/2009:14:36:40 +0200] Discarding unused job-created event...
I [19/Apr/2009:14:36:40 +0200] [Job 131] Adding end banner page "none".
I [19/Apr/2009:14:36:40 +0200] [Job 131] File of type application/postscript queued by "root".
D [19/Apr/2009:14:36:40 +0200] [Job 131] hold_until=0
I [19/Apr/2009:14:36:40 +0200] [Job 131] Queued on "BrotherHL2140Win" by "root".
D [19/Apr/2009:14:36:40 +0200] Discarding unused printer-state-changed event...
D [19/Apr/2009:14:36:40 +0200] [Job 131] job-sheets=none,none
D [19/Apr/2009:14:36:40 +0200] [Job 131] banner_page = 0
D [19/Apr/2009:14:36:40 +0200] [Job 131] argv[0]="BrotherHL2140Win"
D [19/Apr/2009:14:36:40 +0200] [Job 131] argv[1]="131"
D [19/Apr/2009:14:36:40 +0200] [Job 131] argv[2]="root"
D [19/Apr/2009:14:36:40 +0200] [Job 131] argv[3]="Test Page"
D [19/Apr/2009:14:36:40 +0200] [Job 131] argv[4]="1"
D [19/Apr/2009:14:36:40 +0200] [Job 131] argv[5]="job-uuid=urn:uuid:d093d973-8459-3102-4c41-82d68b4d545d"
D [19/Apr/2009:14:36:40 +0200] [Job 131] argv[6]="/var/spool/cups/d00131-001"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[9]="SERVER_ADMIN=root at mlpm1860"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[10]="SOFTWARE=CUPS/1.3.10"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[12]="TZ=Europe/Berlin"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[13]="USER=root"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[16]="IPP_PORT=631"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[17]="CHARSET=utf-8"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[18]="LANG=en_US.UTF-8"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[19]="PPD=/etc/cups/ppd/BrotherHL2140Win.ppd"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[20]="RIP_MAX_CACHE=8m"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[21]="CONTENT_TYPE=application/postscript"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[22]="DEVICE_URI=smb://192.168.0.2/BrotherH"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[23]="PRINTER=BrotherHL2140Win"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[24]="FINAL_CONTENT_TYPE=printer/BrotherHL2140Win"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[25]="AUTH_U****"
D [19/Apr/2009:14:36:40 +0200] [Job 131] envp[26]="AUTH_P****"
I [19/Apr/2009:14:36:40 +0200] [Job 131] Started filter /usr/lib/cups/filter/pstopdf (PID 12277)
I [19/Apr/2009:14:36:40 +0200] [Job 131] Started filter /usr/lib/cups/filter/pdftopdf (PID 12279)
I [19/Apr/2009:14:36:40 +0200] [Job 131] Started filter /usr/lib/cups/filter/cpdftocps (PID 12281)
I [19/Apr/2009:14:36:40 +0200] [Job 131] Started filter /usr/lib/cups/filter/brlpdwrapperHL2140 (PID 12285)
I [19/Apr/2009:14:36:40 +0200] [Job 131] Started backend /usr/lib/cups/backend/smb (PID 12289)
D [19/Apr/2009:14:36:40 +0200] Discarding unused job-state-changed event...
D [19/Apr/2009:14:36:40 +0200] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [19/Apr/2009:14:36:40 +0200] [Job 131] pstopdf 6 args: 131 root Test Page 1 job-uuid=urn:uuid:d093d973-8459-3102-4c41-82d68b4d545d /var/spool/cups/d00131-001
D [19/Apr/2009:14:36:40 +0200] [Job 131] PPD: /etc/cups/ppd/BrotherHL2140Win.ppd
D [19/Apr/2009:14:36:40 +0200] PID 12276 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [19/Apr/2009:14:36:40 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:40 +0200] cupsdCloseClient: 12
D [19/Apr/2009:14:36:40 +0200] Script header: Content-Type: text/html;charset=utf-8
D [19/Apr/2009:14:36:40 +0200] Script header:
D [19/Apr/2009:14:36:40 +0200] [Job 131] Connected with username/password...
D [19/Apr/2009:14:36:40 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:40 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:40 +0200] [Job 131] Resolution: 600
D [19/Apr/2009:14:36:41 +0200] [Job 131] Page size: A4
D [19/Apr/2009:14:36:41 +0200] [Job 131] Width: 595, height: 842, absolute margins: 18, 12, 577, 830
D [19/Apr/2009:14:36:41 +0200] [Job 131] Relative margins: 18, 12, 18, 12
D [19/Apr/2009:14:36:41 +0200] [Job 131] PPD options: -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842
D [19/Apr/2009:14:36:41 +0200] [Job 131] PostScript to be injected:
D [19/Apr/2009:14:36:41 +0200] [Job 131] Running cat | /usr/bin/ps2pdf13 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode                -dDoNumCopies -dPDFSETTINGS=/printer -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 - -
D [19/Apr/2009:14:36:41 +0200] [Job 131] GPL Ghostscript 8.64: Set UseCIEColor for UseDeviceIndependentColor to work properly.
D [19/Apr/2009:14:36:41 +0200] PID 12277 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [19/Apr/2009:14:36:42 +0200] PID 12279 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [19/Apr/2009:14:36:42 +0200] [Job 131] Device copies: 1; device collate:
D [19/Apr/2009:14:36:42 +0200] [Job 131] pdftops - copying to temp print file "/var/spool/cups/tmp/49eb1ada2a3ce"
D [19/Apr/2009:14:36:42 +0200] [Job 131] Page = 595x842; 18,12 to 577,830
D [19/Apr/2009:14:36:42 +0200] [Job 131] slow_collate=0, slow_duplex=0, slow_order=0
D [19/Apr/2009:14:36:42 +0200] [Job 131] Before copy_comments - %!PS-Adobe-3.0
D [19/Apr/2009:14:36:42 +0200] [Job 131] %!PS-Adobe-3.0
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%Pages: (atend)
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%BoundingBox: (atend)
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%HiResBoundingBox: (atend)
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%Creator: GPL Ghostscript 864 (pswrite)
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%CreationDate: 2009/04/19 14:36:42
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%DocumentData: Clean7Bit
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%LanguageLevel: 3
D [19/Apr/2009:14:36:42 +0200] [Job 131] %%EndComments
D [19/Apr/2009:14:36:42 +0200] [Job 131] Before copy_prolog - %%BeginProlog
D [19/Apr/2009:14:36:42 +0200] [Job 131] Before copy_setup - %%Page: 1 1
D [19/Apr/2009:14:36:42 +0200] [Job 131] Before page loop - %%Page: 1 1
D [19/Apr/2009:14:36:42 +0200] [Job 131] Copying page 1...
D [19/Apr/2009:14:36:42 +0200] [Job 131] pagew = 559.0, pagel = 818.0
D [19/Apr/2009:14:36:42 +0200] [Job 131] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [19/Apr/2009:14:36:42 +0200] [Job 131] PageLeft = 18.0, PageRight = 577.0
D [19/Apr/2009:14:36:42 +0200] [Job 131] PageTop = 830.0, PageBottom = 12.0
D [19/Apr/2009:14:36:42 +0200] [Job 131] PageWidth = 595.0, PageLength = 842.0
D [19/Apr/2009:14:36:42 +0200] [Job 131] Wrote 1 pages...
D [19/Apr/2009:14:36:42 +0200] PID 12281 (/usr/lib/cups/filter/cpdftocps) exited with no errors.
D [19/Apr/2009:14:36:43 +0200] cupsdReadClient: 8 GET /printers/BrotherHL2140Win HTTP/1.1
D [19/Apr/2009:14:36:43 +0200] cupsdAuthorize: Authorized as root using Basic
D [19/Apr/2009:14:36:43 +0200] [CGI] /usr/lib/cups/cgi-bin/printers.cgi started - PID = 12412
I [19/Apr/2009:14:36:43 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=12412)
D [19/Apr/2009:14:36:43 +0200] cupsdSendCommand: 8 file=9
D [19/Apr/2009:14:36:43 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [19/Apr/2009:14:36:43 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [19/Apr/2009:14:36:43 +0200] cupsdAuthorize: No authentication data provided.
D [19/Apr/2009:14:36:43 +0200] CUPS-Get-Default
D [19/Apr/2009:14:36:43 +0200] CUPS-Get-Default client-error-not-found: No default printer
D [19/Apr/2009:14:36:43 +0200] cupsdProcessIPPRequest: 11 status_code=406 (client-error-not-found)
D [19/Apr/2009:14:36:43 +0200] [CGI] show_printer(http=0xb879baa8, printer="BrotherHL2140Win")
D [19/Apr/2009:14:36:43 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [19/Apr/2009:14:36:43 +0200] cupsdAuthorize: No authentication data provided.
D [19/Apr/2009:14:36:43 +0200] Get-Printer-Attributes ipp://localhost/printers/BrotherHL2140Win
D [19/Apr/2009:14:36:43 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [19/Apr/2009:14:36:43 +0200] cupsdAuthorize: No authentication data provided.
D [19/Apr/2009:14:36:43 +0200] Get-Jobs ipp://localhost:631/printers/BrotherHL2140Win
D [19/Apr/2009:14:36:43 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [19/Apr/2009:14:36:43 +0200] Script header: Content-Type: text/html;charset=utf-8
D [19/Apr/2009:14:36:43 +0200] Script header:
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] PID 12412 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] cupsdCloseClient: 11
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:43 +0200] PID 12285 (/usr/lib/cups/filter/brlpdwrapperHL2140) exited with no errors.
D [19/Apr/2009:14:36:43 +0200] PID 12289 (/usr/lib/cups/backend/smb) exited with no errors.
D [19/Apr/2009:14:36:43 +0200] [Job 131] File 0 is complete.
I [19/Apr/2009:14:36:43 +0200] [Job 131] Completed successfully.
D [19/Apr/2009:14:36:43 +0200] Discarding unused printer-state-changed event...
D [19/Apr/2009:14:36:43 +0200] Discarding unused job-completed event...
D [19/Apr/2009:14:36:44 +0200] [Job 131] Unloading...
D [19/Apr/2009:14:36:53 +0200] cupsdReadClient: 8 GET /printers/BrotherHL2140Win HTTP/1.1
D [19/Apr/2009:14:36:53 +0200] cupsdAuthorize: Authorized as root using Basic
D [19/Apr/2009:14:36:53 +0200] [CGI] /usr/lib/cups/cgi-bin/printers.cgi started - PID = 12416
I [19/Apr/2009:14:36:53 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=12416)
D [19/Apr/2009:14:36:53 +0200] cupsdSendCommand: 8 file=9
D [19/Apr/2009:14:36:53 +0200] cupsdAcceptClient: 11 from localhost (Domain)
D [19/Apr/2009:14:36:53 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [19/Apr/2009:14:36:53 +0200] cupsdAuthorize: No authentication data provided.
D [19/Apr/2009:14:36:53 +0200] CUPS-Get-Default
D [19/Apr/2009:14:36:53 +0200] CUPS-Get-Default client-error-not-found: No default printer
D [19/Apr/2009:14:36:53 +0200] cupsdProcessIPPRequest: 11 status_code=406 (client-error-not-found)
D [19/Apr/2009:14:36:53 +0200] [CGI] show_printer(http=0xb8cd0aa8, printer="BrotherHL2140Win")
D [19/Apr/2009:14:36:53 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [19/Apr/2009:14:36:53 +0200] cupsdAuthorize: No authentication data provided.
D [19/Apr/2009:14:36:53 +0200] Get-Printer-Attributes ipp://localhost/printers/BrotherHL2140Win
D [19/Apr/2009:14:36:53 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [19/Apr/2009:14:36:53 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:53 +0200] cupsdReadClient: 11 POST / HTTP/1.1
D [19/Apr/2009:14:36:53 +0200] cupsdAuthorize: No authentication data provided.
D [19/Apr/2009:14:36:53 +0200] Get-Jobs ipp://localhost:631/printers/BrotherHL2140Win
D [19/Apr/2009:14:36:53 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
D [19/Apr/2009:14:36:53 +0200] Script header: Content-Type: text/html;charset=utf-8
D [19/Apr/2009:14:36:53 +0200] Script header:
D [19/Apr/2009:14:36:53 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [19/Apr/2009:14:36:53 +0200] PID 12416 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [19/Apr/2009:14:36:53 +0200] cupsdCloseClient: 11

I did even try to reinstall the driver by following the installation instructions again, that did not show any effect.

Any ideas?

Matthias Larisch