Gentoo Forums
Gentoo Forums
Gentoo Forums
Quick Search: in
[SOLVED] Brother mfc-j430w stops working with cups update
View unanswered posts
View posts from last 24 hours

 
Reply to topic    Gentoo Forums Forum Index Unsupported Software
View previous topic :: View next topic  
Author Message
i92guboj
Bodhisattva
Bodhisattva


Joined: 30 Nov 2004
Posts: 10315
Location: Córdoba (Spain)

PostPosted: Tue Feb 18, 2014 5:14 pm    Post subject: [SOLVED] Brother mfc-j430w stops working with cups update Reply with quote

I have no idea if the problem is in ghostscript, in cups, in cups-filters (which now is supposed to substiture foomatic-filters) or my drivers, from here. But today I update cups which pushed cups-filters, and uninstalled foomatic-filters. That broke my printing system. Then I thought "oh, well, let's go to the brother site, and update the drivers", which probably made it worse.

The fact is that, every time someone decides that changing the printing stack would be funny, my printers stop working for one reason or another. I really hate that. :evil:

I am posting here because I am using a driver that's not in portage. The procedure to install it is a bit weird as well, since I am using rpm, like this:

Code:
# rpm -i --nodeps --replacepkgs mfcj430wlpr-3.0.1-1.i386.rpm mfcj430wcupswrapper-3.0.0-1.i386.rpm


The driver appears in the web frontend, I can configure my printer at socket://<ip>/binary_p1, but then sending a test page to the printer says that it can't find /usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w. Since this file is not in the rpms at all, I started randomly linking files to that, and finally did this:

Code:
ln /opt/brother/Printers/mfcj430w/cupswrapper/cupswrappermfcj430w /usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w -nfs


With this, it seems to work, in the sense that I cna send jobs to the printer. The front led display of the printer even lights up when I send a test page, that's a sign that the network connection is ok, and something is reaching the destination. But obviously it must be crap, because the test page still doesn't come out.

This is the output (with debug enable in cupsd.conf) when I launch the test page:

Code:

D [18/Feb/2014:18:13:36 +0100] [Client 13] POST /printers/Sister HTTP/1.1
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [18/Feb/2014:18:13:36 +0100] [Client 13] Authorized as root using Basic
D [18/Feb/2014:18:13:36 +0100] [CGI] argv[0] = "/usr/libexec/cups/cgi-bin/printers.cgi"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/html"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/libexec/cups"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/run/cups"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[9] = "PATH=/usr/libexec/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@jesgue-laptop"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.7.1"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[13] = "USER=root"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[15] = "CUPS_SERVER=/run/cups/cups.sock"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[17] = "IPP_PORT=631"
D [18/Feb/2014:18:13:36 +0100] [CGI] envp[18] = "AUTH_TYPE=Basic"
D [18/Feb/2014:18:13:36 +0100] [Job 94] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [18/Feb/2014:18:13:36 +0100] [Job 94] envp[30]="AUTH_I****"
I [18/Feb/2014:18:13:36 +0100] [Job 94] Started filter /usr/libexec/cups/filter/bannertopdf (PID 31332)
I [18/Feb/2014:18:13:36 +0100] [Job 94] Started filter /usr/libexec/cups/filter/pdftopdf (PID 31333)
I [18/Feb/2014:18:13:36 +0100] [Job 94] Started filter /usr/libexec/cups/filter/pdftops (PID 31334)
I [18/Feb/2014:18:13:36 +0100] [Job 94] Started filter /usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w (PID 31335)
I [18/Feb/2014:18:13:36 +0100] [Job 94] Started backend /usr/libexec/cups/backend/socket (PID 31336)
D [18/Feb/2014:18:13:36 +0100] Discarding unused job-state-changed event...
D [18/Feb/2014:18:13:36 +0100] [Client 15] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/Sister) from localhost
D [18/Feb/2014:18:13:36 +0100] [Client 15] Content-Length: 171
D [18/Feb/2014:18:13:36 +0100] [Client 15] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=171, response=0xb8507838(IPP_IDLE), pipe_pid=0, file=-1
D [18/Feb/2014:18:13:36 +0100] [Client 15] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [18/Feb/2014:18:13:36 +0100] [Client 15] bytes=0, http_state=0, data_remaining=0
D [18/Feb/2014:18:13:36 +0100] [Client 15] Waiting for request.
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: SERVER_NAME="localhost"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: REMOTE_USER="root"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.7.1"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: SERVER_NAME="localhost"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: REMOTE_USER="root"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.7.1"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetArray: job_uri[0]="/jobs/94"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetArray: job_id[0]="94"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetArray: job_state[0]="3"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetArray: job_state_reasons[0]="none"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: refresh_page="2;URL=/printers/Sister"
D [18/Feb/2014:18:13:36 +0100] [Job 94] pdftops - copying to temp print file "/var/spool/cups/tmp/07a665308eaf2"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: TITLE="Imprimir página de prueba"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: SERVER_NAME="localhost"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: REMOTE_USER="root"
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.7.1"
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] Script header: Content-Type: text/html;charset=utf-8
D [18/Feb/2014:18:13:36 +0100] Script header:
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [CGI] cgiSetVariable: PRINTER_NAME="Sister"
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 15] HTTP_STATE_WAITING Closing on EOF
D [18/Feb/2014:18:13:36 +0100] [Client 15] Closing connection.
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [18/Feb/2014:18:13:36 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:36 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31331, file=16
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:36 +0100] [Client 13] Waiting for request.
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: +connecting-to-device
D [18/Feb/2014:18:13:36 +0100] cupsdMarkDirty(---J-)
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:36 +0100] [Job 94] Looking up "192.168.2.130"...
D [18/Feb/2014:18:13:36 +0100] Discarding unused printer-state-changed event...
D [18/Feb/2014:18:13:36 +0100] PID 31331 (/usr/libexec/cups/cgi-bin/printers.cgi) exited with no errors.
D [18/Feb/2014:18:13:36 +0100] [Job 94] rm: cannot remove '/usr/share/cups/model/Brother/brother_mfcj430w_printer_en.ppd': Permission denied
D [18/Feb/2014:18:13:36 +0100] [Job 94] cp: cannot create regular file '/usr/share/cups/model/Brother/brother_mfcj430w_printer_en.ppd': Permission denied
D [18/Feb/2014:18:13:36 +0100] [Job 94] chmod: changing permissions of '/usr/share/cups/model/Brother/brother_mfcj430w_printer_en.ppd': Operation not permitted
D [18/Feb/2014:18:13:36 +0100] [Job 94] cp: cannot create regular file '/usr/share/ppd/Brother/brother_mfcj430w_printer_en.ppd': Permission denied
D [18/Feb/2014:18:13:36 +0100] [Job 94] chmod: changing permissions of '/usr/share/ppd/Brother/brother_mfcj430w_printer_en.ppd': Operation not permitted
D [18/Feb/2014:18:13:36 +0100] [Job 94] PID 31332 (/usr/libexec/cups/filter/bannertopdf) exited with no errors.
D [18/Feb/2014:18:13:36 +0100] [Job 94] Printer make and model: Brother MFC-J430W
D [18/Feb/2014:18:13:36 +0100] [Job 94] No resolution information found in the PPD file.
D [18/Feb/2014:18:13:36 +0100] [Job 94] PID 31333 (/usr/libexec/cups/filter/pdftopdf) exited with no errors.
D [18/Feb/2014:18:13:36 +0100] [Job 94] Using image rendering resolution 300 dpi
D [18/Feb/2014:18:13:36 +0100] [Job 94] Started filter pdftops (PID 31359)
D [18/Feb/2014:18:13:36 +0100] [Job 94] Started filter pstops (PID 31360)
D [18/Feb/2014:18:13:36 +0100] [Job 94] Page = 595x842; 1,1 to 594,841
D [18/Feb/2014:18:13:36 +0100] [Job 94] slow_collate=0, slow_duplex=0, slow_order=0
D [18/Feb/2014:18:13:36 +0100] [Job 94] Before copy_comments - %!PS-Adobe-3.0
D [18/Feb/2014:18:13:36 +0100] [Job 94] %!PS-Adobe-3.0
D [18/Feb/2014:18:13:36 +0100] [Job 94] %Produced by poppler pdftops version: 0.24.5 (http://poppler.freedesktop.org)
D [18/Feb/2014:18:13:36 +0100] [Job 94] %%Creator: cairo 1.10.2 (http://cairographics.org)
D [18/Feb/2014:18:13:36 +0100] [Job 94] %%LanguageLevel: 2
D [18/Feb/2014:18:13:36 +0100] [Job 94] %%DocumentSuppliedResources: (atend)
D [18/Feb/2014:18:13:36 +0100] [Job 94] %%DocumentMedia: 595x842 595 842 0 () ()
D [18/Feb/2014:18:13:36 +0100] [Job 94] %%BoundingBox: 0 0 595 842
dge"','"Cyan Ink Cartridge"','"Magenta Ink Cartridge"','"Ink Absorber"'
D [18/Feb/2014:18:13:36 +0100] cupsdMarkDirty(P----)
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:36 +0100] [Job 94] ATTR: marker-types=ink-cartridge,ink-cartridge,ink-cartridge,ink-cartridge,waste-ink
D [18/Feb/2014:18:13:36 +0100] cupsdMarkDirty(P----)
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:36 +0100] [Job 94] ATTR: marker-levels=-1,-1,-1,-1,-1
D [18/Feb/2014:18:13:36 +0100] cupsdMarkDirty(P----)
D [18/Feb/2014:18:13:36 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:36 +0100] [Job 94] new_supply_state=0, change_state=ffff
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -developer-low-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -developer-empty-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -marker-supply-low-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -marker-supply-empty-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -opc-near-eol-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -opc-life-over-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -toner-low-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -toner-empty-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -waste-receptacle-almost-full-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -waste-receptacle-full-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -cleaner-life-almost-over-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -cleaner-life-over-warning
D [18/Feb/2014:18:13:36 +0100] Discarding unused printer-state-changed event...
D [18/Feb/2014:18:13:36 +0100] [Job 94] new_state=0, change_state=ffff
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -media-empty-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -door-open-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -media-jam-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -input-tray-missing-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -output-tray-missing-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -marker-supply-missing-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -output-area-almost-full-report
D [18/Feb/2014:18:13:36 +0100] [Job 94] STATE: -output-area-full-warning
D [18/Feb/2014:18:13:36 +0100] [Job 94] backendWaitLoop(snmp_fd=5, addr=0xb856fc8c, side_cb=0xb77fb92c)
D [18/Feb/2014:18:13:37 +0100] [Job 94] Before page loop - %%Page: 1 1
D [18/Feb/2014:18:13:37 +0100] [Job 94] Copying page 1...
D [18/Feb/2014:18:13:37 +0100] [Job 94] pagew = 593.0, pagel = 840.0
D [18/Feb/2014:18:13:37 +0100] [Job 94] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Feb/2014:18:13:37 +0100] [Job 94] PageLeft = 1.0, PageRight = 594.0
D [18/Feb/2014:18:13:37 +0100] [Job 94] PageTop = 841.0, PageBottom = 1.0
D [18/Feb/2014:18:13:37 +0100] [Job 94] PageWidth = 595.0, PageLength = 842.0
D [18/Feb/2014:18:13:38 +0100] [Job 94] /usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w: 308: /usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w: lpinfo: not found
D [18/Feb/2014:18:13:38 +0100] [Job 94] /usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w: 353: /usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w: lpadmin: not found
D [18/Feb/2014:18:13:38 +0100] [Job 94] Connecting to 192.168.2.130:9100
D [18/Feb/2014:18:13:38 +0100] [Job 94] PID 31335 (/usr/libexec/cups/filter/brother_lpdwrapper_mfcj430w) exited with no errors.
I [18/Feb/2014:18:13:38 +0100] [Job 94] Conectando a la impresora.
D [18/Feb/2014:18:13:38 +0100] cupsdMarkDirty(---J-)
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:38 +0100] [Job 94] Set job-printer-state-message to "Conectando a la impresora.", current level=INFO
D [18/Feb/2014:18:13:38 +0100] Discarding unused job-progress event...
D [18/Feb/2014:18:13:38 +0100] Discarding unused printer-state-changed event...
D [18/Feb/2014:18:13:38 +0100] [Job 94] STATE: -connecting-to-device
D [18/Feb/2014:18:13:38 +0100] cupsdMarkDirty(---J-)
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:38 +0100] Discarding unused printer-state-changed event...
I [18/Feb/2014:18:13:38 +0100] [Job 94] Conectado a la impresora.
D [18/Feb/2014:18:13:38 +0100] cupsdMarkDirty(---J-)
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:38 +0100] [Job 94] Set job-printer-state-message to "Conectado a la impresora.", current level=INFO
D [18/Feb/2014:18:13:38 +0100] [Job 94] Connected to 192.168.2.130:9100...
D [18/Feb/2014:18:13:38 +0100] [Job 94] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0xb856fc8c, use_bc=1, side_cb=0xb77fb92c)
I [18/Feb/2014:18:13:38 +0100] [Job 94] Esperando a que finalice la impresora.
D [18/Feb/2014:18:13:38 +0100] cupsdMarkDirty(---J-)
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:38 +0100] [Job 94] Set job-printer-state-message to "Esperando a que finalice la impresora.", current level=INFO
D [18/Feb/2014:18:13:38 +0100] Discarding unused job-progress event...
D [18/Feb/2014:18:13:38 +0100] Discarding unused printer-state-changed event...
D [18/Feb/2014:18:13:38 +0100] [Job 94] ATTR: marker-levels=-1,-1,-1,-1,-1
D [18/Feb/2014:18:13:38 +0100] cupsdMarkDirty(P----)
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:38 +0100] [Job 94] new_supply_state=0, change_state=0
D [18/Feb/2014:18:13:38 +0100] Discarding unused printer-state-changed event...
D [18/Feb/2014:18:13:38 +0100] [Job 94] new_state=0, change_state=0
D [18/Feb/2014:18:13:38 +0100] [Job 94] PID 31336 (/usr/libexec/cups/backend/socket) exited with no errors.
D [18/Feb/2014:18:13:38 +0100] [Job 94] Wrote 1 pages...
D [18/Feb/2014:18:13:38 +0100] [Job 94] PID 31359 (pdftops) exited with no errors.
D [18/Feb/2014:18:13:38 +0100] [Job 94] PID 31360 (pstops) exited with no errors.
D [18/Feb/2014:18:13:38 +0100] [Job 94] PID 31334 (/usr/libexec/cups/filter/pdftops) exited with no errors.
D [18/Feb/2014:18:13:38 +0100] [Job 94] time-at-completed=1392743618
D [18/Feb/2014:18:13:38 +0100] Discarding unused job-completed event...
I [18/Feb/2014:18:13:38 +0100] [Job 94] Job completed.
D [18/Feb/2014:18:13:38 +0100] cupsdMarkDirty(---J-)
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:38 +0100] Discarding unused printer-state-changed event...
D [18/Feb/2014:18:13:38 +0100] cupsdMarkDirty(---J-)
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:38 +0100] [Client 13] GET /printers/Sister HTTP/1.1
D [18/Feb/2014:18:13:38 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [18/Feb/2014:18:13:38 +0100] [Client 13] Authorized as root using Basic
D [18/Feb/2014:18:13:38 +0100] [CGI] argv[0] = "/usr/libexec/cups/cgi-bin/printers.cgi"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/html"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/libexec/cups"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/run/cups"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[9] = "PATH=/usr/libexec/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@jesgue-laptop"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.7.1"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[13] = "USER=root"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[15] = "CUPS_SERVER=/run/cups/cups.sock"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[17] = "IPP_PORT=631"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[18] = "AUTH_TYPE=Basic"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[19] = "LANG=es.UTF8"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[20] = "REDIRECT_STATUS=1"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[22] = "SERVER_NAME=localhost"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[23] = "SERVER_PORT=631"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[24] = "REMOTE_ADDR=127.0.0.1"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[25] = "REMOTE_HOST=localhost"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[26] = "SCRIPT_NAME=/printers/Sister"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/html/printers/Sister"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[28] = "PATH_INFO=/Sister"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[29] = "REMOTE_USER=root"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[30] = "SERVER_PROTOCOL=HTTP/1.1"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[31] = "HTTP_COOKIE=org.cups.sid=a6f0c35c4f61be58c9d6ccaa3717e3a4"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[32] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/32.0.1700.107 Safari/537.36"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[33] = "HTTP_REFERER=http://localhost:631/printers/Sister"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[34] = "REQUEST_METHOD=GET"
D [18/Feb/2014:18:13:38 +0100] [CGI] envp[35] = "QUERY_STRING="
D [18/Feb/2014:18:13:38 +0100] [CGI] Started /usr/libexec/cups/cgi-bin/printers.cgi (PID 31362)
I [18/Feb/2014:18:13:38 +0100] [Client 13] Started "/usr/libexec/cups/cgi-bin/printers.cgi" (pid=31362)
D [18/Feb/2014:18:13:38 +0100] [Client 13] file=15
D [18/Feb/2014:18:13:38 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:38 +0100] [CGI] org.cups.sid cookie is "a6f0c35c4f61be58c9d6ccaa3717e3a4"
D [18/Feb/2014:18:13:38 +0100] [CGI] cgiSetVariable: SECTION="printers"
D [18/Feb/2014:18:13:38 +0100] [CGI] cgiSetVariable: REFRESH_PAGE=""
, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:38 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:38 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:38 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:38 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:38 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:38 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:38 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:38 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:38 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:38 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:38 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Job 94] Unloading...
D [18/Feb/2014:18:13:39 +0100] [CGI] Regular expression ".*Clean.*"
D [18/Feb/2014:18:13:39 +0100] [CGI] matches[0].rm_so=0
D [18/Feb/2014:18:13:39 +0100] [CGI] matches[1].rm_so=-1
D [18/Feb/2014:18:13:39 +0100] [CGI] Regular expression ".*PrintSelfTestPage.*"
D [18/Feb/2014:18:13:39 +0100] [CGI] matches[0].rm_so=0
D [18/Feb/2014:18:13:39 +0100] [CGI] matches[1].rm_so=-1
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 16] POST / HTTP/1.1
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 16] No authentication data provided.
D [18/Feb/2014:18:13:39 +0100] [Client 16] 2.0 Get-Jobs 3
D [18/Feb/2014:18:13:39 +0100] Get-Jobs ipp://localhost:631/printers/Sister
D [18/Feb/2014:18:13:39 +0100] [Client 16] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/Sister) from localhost
D [18/Feb/2014:18:13:39 +0100] [Client 16] Content-Length: 72
D [18/Feb/2014:18:13:39 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=72, response=0xb846a578(IPP_IDLE), pipe_pid=0, file=-1
D [18/Feb/2014:18:13:39 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [18/Feb/2014:18:13:39 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
D [18/Feb/2014:18:13:39 +0100] [Client 16] Waiting for request.
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiClearVariables called.
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiSetVariable: ORDER="asc"
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiSetVariable: SECTION="printers"
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiSetVariable: TOTAL="0"
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiSetVariable: PRINTER_NAME="Sister"
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED="/printers/Sister"
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiSetVariable: THISURL="/printers/Sister"
D [18/Feb/2014:18:13:39 +0100] [CGI] cgiSetVariable: SEARCH_DEST="Sister"
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
D [18/Feb/2014:18:13:39 +0100] [Client 16] Closing connection.
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [18/Feb/2014:18:13:39 +0100] PID 31362 (/usr/libexec/cups/cgi-bin/printers.cgi) exited with no errors.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] CGI data ready to be sent.
D [18/Feb/2014:18:13:39 +0100] [Client 13] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_CHUNKED, data_remaining=0, response=(nil)(), pipe_pid=31362, file=15
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for CGI data.
D [18/Feb/2014:18:13:39 +0100] [Client 13] Waiting for request.
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 13] GET /cups.css HTTP/1.1
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 13] Authorized as root using Basic
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 14] GET /images/left.gif HTTP/1.1
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 14] Authorized as root using Basic
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 13] GET /images/right.gif HTTP/1.1
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [18/Feb/2014:18:13:39 +0100] [Client 13] Authorized as root using Basic
D [18/Feb/2014:18:13:39 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"


Yeah. I really hope that has any meaning at all for some expert eye out there, because I can't certainly make any sense out of it.

Thanks for any idea.


Last edited by i92guboj on Wed Feb 19, 2014 12:39 pm; edited 1 time in total
Back to top
View user's profile Send private message
kernelOfTruth
Watchman
Watchman


Joined: 20 Dec 2005
Posts: 6111
Location: Vienna, Austria; Germany; hello world :)

PostPosted: Wed Feb 19, 2014 2:35 am    Post subject: Reply with quote

well, the filter is crucial:

try whether the filter is in the deb (or rpm) [ http://welcome.solutions.brother.com/bsc/public_s/id/linux/en/download_prn.html#MFC-J430W ]

installing it via rpm or dpkg sometimes didn't work for me so

extracting via deb2targz or rpm2targz should help to get all files


also make sure that permissions are somewhat lax - otherwise it wouldn't work,

hope that helps somewhat


for troubleshooting purposes:

connect it locally first



it's weird, that it worked before and now it doesn't

is reverting the changes and option ? (and saving the ebuilds in an local overlay in case it's the only working configuration/setup)
_________________
https://github.com/kernelOfTruth/ZFS-for-SystemRescueCD/tree/ZFS-for-SysRescCD-4.9.0
https://github.com/kernelOfTruth/pulseaudio-equalizer-ladspa

Hardcore Gentoo Linux user since 2004 :D
Back to top
View user's profile Send private message
darklegion
Guru
Guru


Joined: 14 Nov 2004
Posts: 468

PostPosted: Wed Feb 19, 2014 6:25 am    Post subject: Reply with quote

You might want to check if the hplip driver now supports your printer. I had a Brother printer that stopped working recently and had similar symptoms with the prop. Brother drivers. Switching to hplip with the hpijs useflag enabled allowed me to use the printer again.

I think I needed to download a ppd as well, but YMMV.
Back to top
View user's profile Send private message
i92guboj
Bodhisattva
Bodhisattva


Joined: 30 Nov 2004
Posts: 10315
Location: Córdoba (Spain)

PostPosted: Wed Feb 19, 2014 7:31 am    Post subject: Reply with quote

kernelOfTruth wrote:
well, the filter is crucial:

try whether the filter is in the deb (or rpm) [ http://welcome.solutions.brother.com/bsc/public_s/id/linux/en/download_prn.html#MFC-J430W ]

installing it via rpm or dpkg sometimes didn't work for me so

extracting via deb2targz or rpm2targz should help to get all files


I suspect there's something seriously messed up. In rage I probably made it worse, I should really learn to not blindly update this box. When it comes to printing, linux is still in its infancy. You always get problems when updating, and for the few models that work out of the box, you can never get all the features nor the same quality levels that in other OSes. But enough ranting for now. This is getting cyclical...

Quote:
also make sure that permissions are somewhat lax - otherwise it wouldn't work,

hope that helps somewhat


That's what I am looking at right now, along with some other things... Thanks for the suggestions, please, keep them coming :)

Quote:
it's weird, that it worked before and now it doesn't


It printed the past week. I am sure. I am also sure the printer is ok, because it's working from some other computers. Hell, it's even working from a Puppy Linux VM which I have installed in this same box just to try.

Quote:
is reverting the changes and option ? (and saving the ebuilds in an local overlay in case it's the only working configuration/setup)


I wish ext4 had volume snapshoting. I have tried going back to ghostscript-9.05, and cups-1.5.3. I had to rescue a lot of files from the gentoo attic, and remove an avahi patch I couldn't find, but got it emerging finally. Unfortunatelly, it didn't make any difference.

Also, I have tested a different printer (Brother as well, unfortunately, but it uses a different driver) and it exhibits the same symptoms. So I know it's not that concrete driver. But it could certainly be related to the way the drivers are installed.

I'll keep you informed :)
Back to top
View user's profile Send private message
i92guboj
Bodhisattva
Bodhisattva


Joined: 30 Nov 2004
Posts: 10315
Location: Córdoba (Spain)

PostPosted: Wed Feb 19, 2014 7:58 am    Post subject: Reply with quote

darklegion wrote:
You might want to check if the hplip driver now supports your printer. I had a Brother printer that stopped working recently and had similar symptoms with the prop. Brother drivers. Switching to hplip with the hpijs useflag enabled allowed me to use the printer again.

I think I needed to download a ppd as well, but YMMV.


Is not hplip for HP printers? 8O
Back to top
View user's profile Send private message
i92guboj
Bodhisattva
Bodhisattva


Joined: 30 Nov 2004
Posts: 10315
Location: Córdoba (Spain)

PostPosted: Wed Feb 19, 2014 11:28 am    Post subject: Reply with quote

I am seeing some ghostscript related messages. I am not sure they are relevant, but I am trying manually and it doesn't seem to work.

Code:
$ cat /home/i92guboj/something.txt | /opt/brother/Printers/mfcj430w/lpd/filtermfcj430w

Error: /invalidfont in /findfont
Operand stack:
   iso1dict   fCourier   --nostringval--   Courier
Execution stack:
   %interp_exit   .runexec2   --nostringval--   --nostringval--   --nostringval--   2   %stopped_push   --nostringval--   --nostringval--   --nostringval--   false   1   %stopped_push   1900   1   3   %oparray_pop   1899   1   3   %oparray_pop   1883   1   3   %oparray_pop   1771   1   3   %oparray_pop   --nostringval--   %errorexec_pop   .runexec2   --nostringval--   --nostringval--   --nostringval--   2   %stopped_push   --nostringval--   --nostringval--   1852   4   5   %oparray_pop
Dictionary stack:
   --dict:1175/1684(ro)(G)--   --dict:0/20(G)--   --dict:78/200(L)--   --dict:56/200(L)--   --dict:0/8(L)--
Current allocation mode is local
Last OS error: No such file or directory
GPL Ghostscript 9.10: Unrecoverable error, exit code 1


I know nothing about ghostscript. I guess I have some research to do.
Back to top
View user's profile Send private message
kernelOfTruth
Watchman
Watchman


Joined: 20 Dec 2005
Posts: 6111
Location: Vienna, Austria; Germany; hello world :)

PostPosted: Wed Feb 19, 2014 12:27 pm    Post subject: Reply with quote

remembering the foomatic update afaik foomatic-filters had to be uninstalled because it didn't work with the other packages (conflicts) so the following now is installed:

Code:
qlist -I -C net-print/foomatic
net-print/foomatic-db
net-print/foomatic-db-engine
net-print/foomatic-db-ppds



besides that ghostscript-gpl, cups, cups-filters are all up-to-date here

and the printer works (albeit locally, it's a HL5240, haven't tried the other mfc one, will do later)
_________________
https://github.com/kernelOfTruth/ZFS-for-SystemRescueCD/tree/ZFS-for-SysRescCD-4.9.0
https://github.com/kernelOfTruth/pulseaudio-equalizer-ladspa

Hardcore Gentoo Linux user since 2004 :D
Back to top
View user's profile Send private message
i92guboj
Bodhisattva
Bodhisattva


Joined: 30 Nov 2004
Posts: 10315
Location: Córdoba (Spain)

PostPosted: Wed Feb 19, 2014 12:38 pm    Post subject: Reply with quote

Crap, crap, crap, and now clap clap clap. :lol:

You can come and rip my head of If I know what's going on. But, to the point.

My most recent finding is that, disabling the infinality fontconfig engine seems to fix the issue. Don't ask me, why, plus I am perfectly sure I printed from here the last week, and infinality has been installed here for months, maybe one year.

I found one hint to this while searching around the net:

http://www.infinality.net/forum/viewtopic.php?f=2&t=238

After that, without much faith, I did this:

Code:
eselect fontconfig list


Looked at the infinality line, noted the number, call it X, then

Code:
eselect fontconfig disable X


After that, I tried to use the filter as above, and instead of the error I got:

Code:

$ cat ~/cups|/opt/brother/Printers/mfcj430w/lpd/filtermfcj430w


RIADNNPsSF
           F
            yUSQYXIAFÿFÿFÿFÿFÿFÿFÿFÿFx1
                                       


Well, that's certainly nicer. So I went to the web cups frontend, fired up the test page option, and it printed.

So, this crap seems to be some kind of incompatibility between the brother filters and infinality, but ghost script is somewhat in the middle. I haven't found any direct reference to gs directly in the readable brother scripts. So it must be one of the binary tools they ship which is crapping the whole thing. But, as said, I could print perfectly some days ago.

The latest related update was cups-1.7 and ghostscript-9.10 yesterday, so something must have gone wrong there. And, as said, the infinality stuff has been there for long, and it wasn't causing any problem (well, it was, but not THIS problem).

The last step was to edit /etc/fonts/infinality/infinality.conf and comment out the section that is blocking Type 1 fonts altogether, like this:

Code:

        <!-- Ban Type-1 fonts because they render poorly -->
        <!-- Comment this out to allow all Type 1 fonts -->
        <!--<selectfont>
                <rejectfont>
                        <pattern>
                                <patelt name="fontformat" >
                                        <string>Type 1</string>
                                </patelt>
                        </pattern>
                </rejectfont>
        </selectfont>
        -->


Then I enabled infinality again, with eselect, and I can still print.

So, I think this is over. Or so I hope. I'll for sure bookmark this, since it'll be breaking the next time infinality is updated.
Back to top
View user's profile Send private message
i92guboj
Bodhisattva
Bodhisattva


Joined: 30 Nov 2004
Posts: 10315
Location: Córdoba (Spain)

PostPosted: Wed Feb 19, 2014 12:46 pm    Post subject: Reply with quote

It seems there's a bug on this one:

https://bugs.gentoo.org/show_bug.cgi?id=494764

By the way, thanks a ton to everyone that took the time to read or answer. :)
Back to top
View user's profile Send private message
kernelOfTruth
Watchman
Watchman


Joined: 20 Dec 2005
Posts: 6111
Location: Vienna, Austria; Germany; hello world :)

PostPosted: Wed Feb 19, 2014 1:30 pm    Post subject: Reply with quote

8O

so that was the reason why I couldn't reproduce

had disabled that option long time ago on a "crusade" to beautify my desktop

I'm sure, I'll come across this issue in the near future when updating

so good to know that this/can be a source of issue
_________________
https://github.com/kernelOfTruth/ZFS-for-SystemRescueCD/tree/ZFS-for-SysRescCD-4.9.0
https://github.com/kernelOfTruth/pulseaudio-equalizer-ladspa

Hardcore Gentoo Linux user since 2004 :D
Back to top
View user's profile Send private message
xaviermiller
Bodhisattva
Bodhisattva


Joined: 23 Jul 2004
Posts: 8706
Location: ~Brussels - Belgique

PostPosted: Wed Feb 19, 2014 1:46 pm    Post subject: Reply with quote

Oh ! I use infinality and have issues printing on a HP LaserJet, and it worked with a Raspberry Pi which don't have infinality...
_________________
Kind regards,
Xavier Miller
Back to top
View user's profile Send private message
i92guboj
Bodhisattva
Bodhisattva


Joined: 30 Nov 2004
Posts: 10315
Location: Córdoba (Spain)

PostPosted: Wed Feb 19, 2014 1:49 pm    Post subject: Reply with quote

XavierMiller wrote:
Oh ! I use infinality and have issues printing on a HP LaserJet, and it worked with a Raspberry Pi which don't have infinality...


Please, if this turns out to be your same problem, report back in the bug I linked above. If they see that blindly masking fonts that are there for a reason break a lot of different systems they might actually fix it :P
Back to top
View user's profile Send private message
xaviermiller
Bodhisattva
Bodhisattva


Joined: 23 Jul 2004
Posts: 8706
Location: ~Brussels - Belgique

PostPosted: Wed Feb 19, 2014 7:19 pm    Post subject: Reply with quote

Hello,

My CUPS problem is not related to infinality. I will quit that discussion ;)
_________________
Kind regards,
Xavier Miller
Back to top
View user's profile Send private message
darklegion
Guru
Guru


Joined: 14 Nov 2004
Posts: 468

PostPosted: Fri Feb 21, 2014 3:49 pm    Post subject: Reply with quote

i92guboj wrote:
Is not hplip for HP printers? 8O


For the record, it's not just for HP printers despite the name. But it looks like you got everything sorted in any case.
Back to top
View user's profile Send private message
cboldt
Veteran
Veteran


Joined: 24 Aug 2005
Posts: 1046

PostPosted: Sat Feb 22, 2014 8:52 pm    Post subject: Reply with quote

I'm in printer hell too. Can print from the machine that is attached to the printer, but not from any networked machines. The job is accepted from the networked machines, but cups throws "filter errors."

I think the problem is absence of the pswrite device is ghostscript. That device is removed/missing going from ghostview-gpl-9.05 to 9.10.

I can't print from ghostview (9.10) from any machine, getting a "Unknown device: pswrite" report. So, ghostview is itself borked, as well as any filters that use the pswrite driver of ghostscript.

I don't find any issue going from foomatic-filters to cups-filters, the /usr/libexec/cups/filter/gstopxl script is functionally identical between those two.

I can't even figure out a to revert to ghostscript-gpl-9.05.

Very frustrating. To say the least. Good thing my paying job doesn't depend on being able to print.
Back to top
View user's profile Send private message
cboldt
Veteran
Veteran


Joined: 24 Aug 2005
Posts: 1046

PostPosted: Mon Feb 24, 2014 1:19 am    Post subject: Reply with quote

Total misdiagnosis of problem (conflated gv inability with the network printer filter failures); fixed both.

gv not printing was due to use of deprecated "pswrite" DEVICE in /etc/X11/app-defaults/GV

network printing trouble, manifested as filter failures, was due to not telling the remote machines to use a separate print server. Add a line to /etc/cups/client.conf and everything is working. In my case, the printer is attached to network machine named "hypoid."

Code:
ServerName hypoid
Back to top
View user's profile Send private message
Moderato
n00b
n00b


Joined: 02 Jun 2006
Posts: 26
Location: Karlsruhe, Baden-Württemberg, Germany

PostPosted: Fri Mar 14, 2014 11:20 am    Post subject: Reply with quote

Hi,

there is a workaround for printing with even such an infinality breakage. It took me 3 hours to get there yesterday, but I did finally succeeded.

Print whatever you want to print to an SVG image file.

SVG, as a vector image format, is obviously great for printing due to the ability to enlarge it arbitarily without losing information (will come in handy later) if the image is truly vector-based (well, create an SVG with single pixels only and you'll degrade it to a raster image)... which, of course, matches great for text.

Then, go ahead and load the SVG file into GIMP. Use a sensible DPI value when having it imported. Something like 300 DPI or higher is producing OK results on plain A4 paper.

Print the imported file out of GIMP. Send it directly to your printer.

This will work due to the fact that GIMP actually converts the original SVG image with embedded text in $SOMEFONT to some other sort of image, which will not contain ANY text (i.e., the text is being converted to an image.)

This then prints fine and even looks good.


Yes, it's messy and ugly, but it gets the job done.

As another side note: you can't just, for instance, directly print to PS or PDF and print this. You can't even directly print the SVG file. This is due to the fact that all three file formats will embed the text as text with $SOMEFONT, thus making gs barf (which will be invoked by CUPS at print time.)
So, what if you try to be clever and use ImageMagick/convert to convert any of those file formats to a, say, JPG file which cannot embed plain text? Simple answer: ImageMagick is probably using ghostscript to do the conversion. Or even if not, it also fails due to the fonts problem described in great detail in this thread.

Best regards,



Mihai
Back to top
View user's profile Send private message
Display posts from previous:   
Reply to topic    Gentoo Forums Forum Index Unsupported Software All times are GMT
Page 1 of 1

 
Jump to:  
You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum
You cannot vote in polls in this forum