View previous topic :: View next topic |
Author |
Message |
i92guboj Bodhisattva
Joined: 30 Nov 2004 Posts: 10315 Location: Córdoba (Spain)
|
Posted: Tue Feb 18, 2014 5:14 pm Post subject: [SOLVED] Brother mfc-j430w stops working with cups update |
|
|
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.
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 |
|
|
kernelOfTruth Watchman
Joined: 20 Dec 2005 Posts: 6111 Location: Vienna, Austria; Germany; hello world :)
|
|
Back to top |
|
|
darklegion Guru
Joined: 14 Nov 2004 Posts: 468
|
Posted: Wed Feb 19, 2014 6:25 am Post subject: |
|
|
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 |
|
|
i92guboj Bodhisattva
Joined: 30 Nov 2004 Posts: 10315 Location: Córdoba (Spain)
|
Posted: Wed Feb 19, 2014 7:31 am Post subject: |
|
|
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 |
|
|
i92guboj Bodhisattva
Joined: 30 Nov 2004 Posts: 10315 Location: Córdoba (Spain)
|
Posted: Wed Feb 19, 2014 7:58 am Post subject: |
|
|
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? |
|
Back to top |
|
|
i92guboj Bodhisattva
Joined: 30 Nov 2004 Posts: 10315 Location: Córdoba (Spain)
|
Posted: Wed Feb 19, 2014 11:28 am Post subject: |
|
|
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 |
|
|
kernelOfTruth Watchman
Joined: 20 Dec 2005 Posts: 6111 Location: Vienna, Austria; Germany; hello world :)
|
|
Back to top |
|
|
i92guboj Bodhisattva
Joined: 30 Nov 2004 Posts: 10315 Location: Córdoba (Spain)
|
Posted: Wed Feb 19, 2014 12:38 pm Post subject: |
|
|
Crap, crap, crap, and now clap clap clap.
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 |
|
|
i92guboj Bodhisattva
Joined: 30 Nov 2004 Posts: 10315 Location: Córdoba (Spain)
|
|
Back to top |
|
|
kernelOfTruth Watchman
Joined: 20 Dec 2005 Posts: 6111 Location: Vienna, Austria; Germany; hello world :)
|
|
Back to top |
|
|
xaviermiller Bodhisattva
Joined: 23 Jul 2004 Posts: 8706 Location: ~Brussels - Belgique
|
Posted: Wed Feb 19, 2014 1:46 pm Post subject: |
|
|
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 |
|
|
i92guboj Bodhisattva
Joined: 30 Nov 2004 Posts: 10315 Location: Córdoba (Spain)
|
Posted: Wed Feb 19, 2014 1:49 pm Post subject: |
|
|
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 |
|
Back to top |
|
|
xaviermiller Bodhisattva
Joined: 23 Jul 2004 Posts: 8706 Location: ~Brussels - Belgique
|
Posted: Wed Feb 19, 2014 7:19 pm Post subject: |
|
|
Hello,
My CUPS problem is not related to infinality. I will quit that discussion _________________ Kind regards,
Xavier Miller |
|
Back to top |
|
|
darklegion Guru
Joined: 14 Nov 2004 Posts: 468
|
Posted: Fri Feb 21, 2014 3:49 pm Post subject: |
|
|
i92guboj wrote: | Is not hplip for HP printers? |
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 |
|
|
cboldt Veteran
Joined: 24 Aug 2005 Posts: 1046
|
Posted: Sat Feb 22, 2014 8:52 pm Post subject: |
|
|
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 |
|
|
cboldt Veteran
Joined: 24 Aug 2005 Posts: 1046
|
Posted: Mon Feb 24, 2014 1:19 am Post subject: |
|
|
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."
|
|
Back to top |
|
|
Moderato n00b
Joined: 02 Jun 2006 Posts: 26 Location: Karlsruhe, Baden-Württemberg, Germany
|
Posted: Fri Mar 14, 2014 11:20 am Post subject: |
|
|
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 |
|
|
|
|
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
|
|