Unable to write print data: Broken pipe

Thu Jul 3 04:21:33 PDT 2008

Verena Alishahi wrote:
>>It usually means that the printer connection timed out - check the
>>idle timeout setting on the printer.
>>
>>The log does show one 8k buffer getting written to the printer - it
>>is possible there is something in the first 8k that is causing the
>>printer to reset the connection as well - make sure the "print PS
>>errors" option is turned on in the printer's control panel menu in
>>case the printer doesn't like something we are sending it.
>>
> 
> 
> I've set the input/output-timelimit from 15 to 150 seconds and I've turned on "print PS errors", but the error is the same. The printer doesn't print a PS error page and it seems, that no data is reaching the printer. The printer is a HP Color LaserJet 4700dn.
> 
> Any ideas?
> 
> D [03/Jul/2008:12:34:28 +0200] cupsdAcceptClient: 8 from localhost:631
>  (IPv4)
> D [03/Jul/2008:12:34:28 +0200] cupsdReadClient: 8 GET /printers/icg17c
> 4?op=print-test-page HTTP/1.1
> D [03/Jul/2008:12:34:28 +0200] cupsdAuthorize: No authentication data
> provided.
> D [03/Jul/2008:12:34:28 +0200] [CGI] /usr/lib/cups/cgi-bin/printers.cg
> i started - PID = 16576
> I [03/Jul/2008:12:34:28 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=16576)
> D [03/Jul/2008:12:34:28 +0200] cupsdSendCommand: 8 file=9
> D [03/Jul/2008:12:34:28 +0200] cupsdAcceptClient: 11 from localhost (Domain)
> D [03/Jul/2008:12:34:28 +0200] cupsdReadClient: 11 POST /printers/icg17c4 HTTP/1.1
> D [03/Jul/2008:12:34:28 +0200] cupsdAuthorize: No authentication data provided.
> D [03/Jul/2008:12:34:28 +0200] Print-Job ipp://localhost:631/printers/icg17c4
> D [03/Jul/2008:12:34:28 +0200] Adding default job-sheets values "none,none"...
> I [03/Jul/2008:12:34:28 +0200] [Job 11] Adding start banner page "none".
> D [03/Jul/2008:12:34:28 +0200] Discarding unused job-created event...
> I [03/Jul/2008:12:34:28 +0200] [Job 11] Adding job file of type application/postscript.
> I [03/Jul/2008:12:34:28 +0200] [Job 11] Adding end banner page "none".
> I [03/Jul/2008:12:34:28 +0200] [Job 11] Queued on "icg17c4" by "anonymous".
> D [03/Jul/2008:12:34:28 +0200] [Job 11] hold_until = 0
> D [03/Jul/2008:12:34:28 +0200] Discarding unused printer-state-changed event...
> D [03/Jul/2008:12:34:28 +0200] [Job 11] job-sheets=none,none
> D [03/Jul/2008:12:34:28 +0200] [Job 11] banner_page = 0
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[0]="icg17c4"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[1]="11"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[2]="anonymous"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[3]="Test Page"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[4]="1"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[5]="job-uuid=urn:uuid:6d3dcedf-17e8-33b6-7c33-49920f141a87"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[6]="/var/spool/cups/d00011-001"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[0]="CUPS_CACHEDIR=/etc/cups/yes"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[1]="CUPS_DATADIR=/usr/share/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[2]="CUPS_DOCROOT=/usr/share/doc/packages/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] argv[6]="/var/spool/cups/d00011-001"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[0]="CUPS_CACHEDIR=/etc/cups/yes"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[1]="CUPS_DATADIR=/usr/share/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[2]="CUPS_DOCROOT=/usr/share/doc/packages/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[6]="CUPS_SERVERROOT=/etc/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[7]="CUPS_STATEDIR=/var/run/cups"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[9]="SERVER_ADMIN=root at icg257.icg.kfa-juelich.de"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[10]="SOFTWARE=CUPS/1.3.7"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[11]="TMPDIR=/tmp"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[12]="USER=root"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[13]="CUPS_SERVER=/var/run/cups/cups.sock"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[14]="CUPS_ENCRYPTION=IfRequested"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[15]="IPP_PORT=631"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[16]="CHARSET=utf-8"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[17]="LANG=en_US.UTF8"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[18]="PPD=/etc/cups/ppd/icg17c4.ppd"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[19]="RIP_MAX_CACHE=8m"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[20]="CONTENT_TYPE=application/postscript"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[21]="DEVICE_URI=socket://icg1048.icg.kfa-juelich.de:9100"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[22]="PRINTER=icg17c4"
> D [03/Jul/2008:12:34:28 +0200] [Job 11] envp[23]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
> I [03/Jul/2008:12:34:28 +0200] [Job 11] Started filter /usr/lib/cups/filter/pstops (PID 16577)
> I [03/Jul/2008:12:34:28 +0200] [Job 11] Started backend /usr/lib/cups/backend/socket (PID 16578)
> D [03/Jul/2008:12:34:28 +0200] Discarding unused job-state-changed event...
> D [03/Jul/2008:12:34:28 +0200] cupsdProcessIPPRequest: 11 status_code=0 (successful-ok)
> D [03/Jul/2008:12:34:28 +0200] PID 16576 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
> D [03/Jul/2008:12:34:28 +0200] cupsdCloseClient: 11
> D [03/Jul/2008:12:34:28 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:28 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:28 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Page = 595x842; 12,12 to 583,830
> D [03/Jul/2008:12:34:28 +0200] [Job 11] slow_collate=0, slow_duplex=0, slow_order=0
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Before copy_comments - %!PS-Adobe-3.0
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %!PS-Adobe-3.0
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%BoundingBox: 0 0 612 792
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%Pages: 1
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%LanguageLevel: 1
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%DocumentData: Clean7Bit
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%DocumentSuppliedResources: procset testprint/1.3
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%Creator: Michael Sweet, Apple Inc.
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%CreationDate: D:20070606214000+0500
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%Title: Test Page
> D [03/Jul/2008:12:34:28 +0200] [Job 11] %%EndComments
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Before copy_prolog - %%BeginProlog
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Before copy_setup - %%Page: 1 1
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Before page loop - %%Page: 1 1
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Copying page 1...
> D [03/Jul/2008:12:34:28 +0200] Discarding unused job-progress event...
> D [03/Jul/2008:12:34:28 +0200] [Job 11] pagew = 571.1, pagel = 817.6
> D [03/Jul/2008:12:34:28 +0200] [Job 11] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
> D [03/Jul/2008:12:34:28 +0200] [Job 11] PageLeft = 12.0, PageRight = 583.1
> D [03/Jul/2008:12:34:28 +0200] [Job 11] PageTop = 829.7, PageBottom = 12.1
> D [03/Jul/2008:12:34:28 +0200] [Job 11] PageWidth = 595.0, PageLength = 842.0
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Wrote 1 pages...
> D [03/Jul/2008:12:34:28 +0200] PID 16577 (/usr/lib/cups/filter/pstops) exited with no errors.
> D [03/Jul/2008:12:34:28 +0200] Discarding unused printer-state-changed event...
> D [03/Jul/2008:12:34:28 +0200] Discarding unused printer-state-changed event...
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Connected to 134.94.154.9:9100 (IPv4)...
> D [03/Jul/2008:12:34:28 +0200] [Job 11] backendRunLoop(print_fd=0, device_fd=5, use_bc=1, side_cb=0x80001050)
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Read 8192 bytes of print data...
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Wrote 8192 bytes of print data...
> D [03/Jul/2008:12:34:28 +0200] [Job 11] Read 8192 bytes of print data...
> D [03/Jul/2008:12:34:28 +0200] Discarding unused printer-state-changed event...
> E [03/Jul/2008:12:34:28 +0200] [Job 11] Unable to write print data: Broken pipe
> D [03/Jul/2008:12:34:28 +0200] Discarding unused printer-state-changed event...
> E [03/Jul/2008:12:34:28 +0200] PID 16578 (/usr/lib/cups/backend/socket) stopped with status 1!
> D [03/Jul/2008:12:34:28 +0200] [Job 11] File 0 is complete.
> I [03/Jul/2008:12:34:28 +0200] [Job 11] Backend returned status 1 (failed)
> D [03/Jul/2008:12:34:28 +0200] Discarding unused printer-state-changed event...
> D [03/Jul/2008:12:34:28 +0200] Discarding unused printer-stopped event...
> I [03/Jul/2008:12:34:28 +0200] Saving printers.conf...
> D [03/Jul/2008:12:34:28 +0200] Discarding unused job-stopped event...
> D [03/Jul/2008:12:34:29 +0200] [Job 11] Unloading...
> D [03/Jul/2008:12:34:30 +0200] cupsdReadClient: 8 GET /printers/icg17c4 HTTP/1.1
> D [03/Jul/2008:12:34:30 +0200] cupsdAuthorize: No authentication data provided.
> D [03/Jul/2008:12:34:30 +0200] [CGI] /usr/lib/cups/cgi-bin/printers.cgi started - PID = 16579
> I [03/Jul/2008:12:34:30 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=16579)
> D [03/Jul/2008:12:34:30 +0200] cupsdSendCommand: 8 file=11
> D [03/Jul/2008:12:34:30 +0200] cupsdAcceptClient: 13 from localhost (Domain)
> D [03/Jul/2008:12:34:30 +0200] cupsdReadClient: 13 POST / HTTP/1.1
> D [03/Jul/2008:12:34:30 +0200] cupsdAuthorize: No authentication data provided.
> D [03/Jul/2008:12:34:30 +0200] CUPS-Get-Default
> D [03/Jul/2008:12:34:30 +0200] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
> D [03/Jul/2008:12:34:30 +0200] [CGI] show_printer(http=0x8001ae48, printer="icg17c4")
> D [03/Jul/2008:12:34:30 +0200] cupsdReadClient: 13 POST / HTTP/1.1
> D [03/Jul/2008:12:34:30 +0200] cupsdAuthorize: No authentication data provided.
> D [03/Jul/2008:12:34:30 +0200] Get-Printer-Attributes ipp://localhost/printers/icg17c4
> D [03/Jul/2008:12:34:30 +0200] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
> D [03/Jul/2008:12:34:30 +0200] cupsdReadClient: 13 POST / HTTP/1.1
> D [03/Jul/2008:12:34:30 +0200] cupsdAuthorize: No authentication data provided.
> D [03/Jul/2008:12:34:30 +0200] Get-Jobs ipp://localhost:631/printers/icg17c4
> D [03/Jul/2008:12:34:30 +0200] [Job 11] Loading attributes...
> D [03/Jul/2008:12:34:30 +0200] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] [CGI] lang="en_US.UTF8", locale="/en_US"...
> D [03/Jul/2008:12:34:30 +0200] cupsdCloseClient: 13
> D [03/Jul/2008:12:34:30 +0200] PID 16579 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
> 
> 
> cheers,
> Verena
> 
> 

I presume you are printing the CUPS test page (inferring this from your log file).
Thus, the job shouldn't contain any statements which might cause
the printer to fail.

But, obviously your queue is configured to use US Letter as the
default format, and I suspect your printer is configured to print
on A4 sheets. Might it be that you need to
a) reconfigure your queue to default to A4
or
b) hit the printer's start button within the timeout period
    (though this may depend on the printer's setup)?

Helge

-- 
Helge Blischke
Softwareentwicklung

H.Blischke at acm.org