Attachment 935004 Details for Bug 1138930 – Cups error log

Cups error log

Job72log.txt (text/plain), 13.76 KB, created by David Anderson on 2014-09-06 12:24:48 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: David Anderson

Created: 2014-09-06 12:24:48 UTC

Size: 13.76 KB

patch

obsolete

>E [06/Sep/2014:11:39:51 +0100] [Job 72] Job stopped due to filter errors; please consult the error_log file for details.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] The following messages were recorded from 11:39:41 to 11:39:51
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Adding start banner page "none".
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Queued on "HP_LaserJet_Professional_M1217nfw_MFP" by "david".
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Auto-typing file...
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Request file type is application/postscript.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] File of type application/postscript queued by "david".
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Adding end banner page "none".
>D [06/Sep/2014:11:39:51 +0100] [Job 72] time-at-processing=1409999981
>D [06/Sep/2014:11:39:51 +0100] [Job 72] 4 filters for job:
>D [06/Sep/2014:11:39:51 +0100] [Job 72] pstopdf (application/postscript to application/pdf, cost 0)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 99)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] hpcups (application/vnd.cups-raster to printer/HP_LaserJet_Professional_M1217nfw_MFP, cost 0)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] job-sheets=none,none
>D [06/Sep/2014:11:39:51 +0100] [Job 72] argv[0]="HP_LaserJet_Professional_M1217nfw_MFP"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] argv[1]="72"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] argv[2]="david"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] argv[3]="June 2014 - Booking Form"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] argv[4]="1"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] argv[5]="noCollate finishings=3 fit-to-page media=A4 number-up=1 outputorder=normal page-bottom=10 page-left=10 page-right=10 page-top=10 portrait sides=one-sided job-uuid=urn:uuid:3cb53f58-8b8b-38bf-4dcf-f76dcaa53d14 job-originating-host-name=localhost time-at-creation=1409999981 time-at-processing=1409999981 PageSize=A4"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] argv[6]="/var/spool/cups/d00072-001"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[8]="HOME=/var/spool/cups/tmp"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[10]="SERVER_ADMIN=root@dhcppc5"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[11]="SOFTWARE=CUPS/1.7.4"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[12]="TMPDIR=/var/spool/cups/tmp"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[13]="USER=root"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[14]="CUPS_MAX_MESSAGE=2047"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[16]="CUPS_ENCRYPTION=IfRequested"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[17]="IPP_PORT=631"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[18]="CHARSET=utf-8"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[19]="LANG=en_GB.UTF-8"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[20]="PPD=/etc/cups/ppd/HP_LaserJet_Professional_M1217nfw_MFP.ppd"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[21]="RIP_MAX_CACHE=128m"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[22]="CONTENT_TYPE=application/postscript"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[23]="DEVICE_URI=hp:/net/HP_LaserJet_Professional_M1217nfw_MFP?ip=192.168.1.2"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[24]="PRINTER_INFO=HP LaserJet M1217nfw"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[25]="PRINTER_LOCATION=Day Close"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[26]="PRINTER=HP_LaserJet_Professional_M1217nfw_MFP"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[27]="PRINTER_STATE_REASONS=none"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[28]="CUPS_FILETYPE=document"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[29]="FINAL_CONTENT_TYPE=printer/HP_LaserJet_Professional_M1217nfw_MFP"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[30]="AUTH_I****"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Started filter /usr/lib/cups/filter/pstopdf (PID 20817)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Started filter /usr/lib/cups/filter/pdftopdf (PID 20818)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Started filter /usr/lib/cups/filter/gstoraster (PID 20819)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Started filter /usr/lib/cups/filter/hpcups (PID 20820)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Started backend /usr/lib/cups/backend/hp (PID 20821)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] pstopdf 6 args: 72 david June 2014 - Booking Form 1 noCollate finishings=3 fit-to-page media=A4 number-up=1 outputorder=normal page-bottom=10 page-left=10 page-right=10 page-top=10 portrait sides=one-sided job-uuid=urn:uuid:3cb53f58-8b8b-38bf-4dcf-f76dcaa53d14 job-originating-host-name=localhost time-at-creation=1409999981 time-at-processing=1409999981 PageSize=A4 /var/spool/cups/d00072-001
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PPD: /etc/cups/ppd/HP_LaserJet_Professional_M1217nfw_MFP.ppd
>D [06/Sep/2014:11:39:51 +0100] [Job 72] STATE: -marker-supply-low-warning
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Resolution: 
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Orientation requested: 0
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Page size: A4
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Width: 595.440002441406, height: 841.679992675781, absolute margins: 18, 15.5, 577.440002441406, 826.179992675781
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Relative margins: 18, 15.5, 18.000000000000, 15.500000000000
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PPD options: -dDEVICEWIDTHPOINTS=595.440002441406 -dDEVICEHEIGHTPOINTS=841.679992675781
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PostScript to be injected: <</.HWMargins[18 15.5 18.000000000000 15.500000000000] /Margins[0 0]>>setpagedevice
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false                -dNOPLATFONTS -dPARANOIDSAFER -dNOINTERPOLATE -sstdout=%stderr -dColorImageFilter=/FlateEncode                 -dPDFSETTINGS=/printer -dUseCIEColor                 -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -dDEVICEWIDTHPOINTS=595.440002441406 -dDEVICEHEIGHTPOINTS=841.679992675781 -sOutputFile=-  -c <</.HWMargins[18 15.5 18.000000000000 15.500000000000] /Margins[0 0]>>setpagedevice .setpdfwrite -f -
>D [06/Sep/2014:11:39:51 +0100] [Job 72] GPL Ghostscript 9.14: 
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Use of -dUseCIEColor detected!
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Since the release of version 9.11 of Ghostscript we recommend you do not set
>D [06/Sep/2014:11:39:51 +0100] [Job 72] -dUseCIEColor with the pdfwrite/ps2write device family.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] GPL Ghostscript 9.14: 
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Use of -dUseCIEColor detected!
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Since the release of version 9.11 of Ghostscript we recommend you do not set
>D [06/Sep/2014:11:39:51 +0100] [Job 72] -dUseCIEColor with the pdfwrite/ps2write device family.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PID 20817 (/usr/lib/cups/filter/pstopdf) exited with no errors.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PID 20818 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Calling FindDeviceById(cups-HP_LaserJet_Professional_M1217nfw_MFP)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_Professional_M1217nfw_MFP
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Calling org.freedesktop.ColorManager.Device.Get(ProfilingInhibitors)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PPD uses qualifier 'Gray.Plain.'
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Calling FindDeviceById(cups-HP_LaserJet_Professional_M1217nfw_MFP)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Found device /org/freedesktop/ColorManager/devices/cups_HP_LaserJet_Professional_M1217nfw_MFP
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Calling GetProfileForQualifiers(Gray.Plain....)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Failed to send: org.freedesktop.ColorManager.Device.NothingMatched:nothing matched expression 'Gray.Plain.,Gray.Plain.*,Gray.*.,Gray.*.*,*'
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Failed to get profile filename for cups-HP_LaserJet_Professional_M1217nfw_MFP
>D [06/Sep/2014:11:39:51 +0100] [Job 72] no profiles specified in PPD
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Set job-printer-state-message to "no profiles specified in PPD", current level=INFO
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -sMediaType=Plain -sOutputType=0 -r600x600 -dMediaPosition=7 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=841 -dcupsBitsPerColor=1 -dcupsColorOrder=0 -dcupsColorSpace=3 -dcupsRowCount=1 -dcupsRowStep=2 -dcupsInteger0=9 -scupsPageSizeName=A4 -I/usr/share/cups/fonts -c '<</.HWMargins[18.000000 15.500000 18.000000 15.500000] /Margins[0 0]>>setpagedevice' -f -_
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[8]="HOME=/var/spool/cups/tmp"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[10]="SERVER_ADMIN=root@dhcppc5"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[11]="SOFTWARE=CUPS/1.7.4"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[12]="TMPDIR=/var/spool/cups/tmp"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[13]="USER=root"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[14]="CUPS_MAX_MESSAGE=2047"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[16]="CUPS_ENCRYPTION=IfRequested"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[17]="IPP_PORT=631"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[18]="CHARSET=utf-8"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[19]="LANG=en_GB.UTF-8"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[20]="PPD=/etc/cups/ppd/HP_LaserJet_Professional_M1217nfw_MFP.ppd"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[21]="RIP_MAX_CACHE=128m"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[22]="CONTENT_TYPE=application/postscript"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[23]="DEVICE_URI=hp:/net/HP_LaserJet_Professional_M1217nfw_MFP?ip=192.168.1.2"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[24]="PRINTER_INFO=HP LaserJet M1217nfw"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[25]="PRINTER_LOCATION=Day Close"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[26]="PRINTER=HP_LaserJet_Professional_M1217nfw_MFP"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[27]="PRINTER_STATE_REASONS=none"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[28]="CUPS_FILETYPE=document"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[29]="FINAL_CONTENT_TYPE=printer/HP_LaserJet_Professional_M1217nfw_MFP"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] envp[30]="AUTH_INFO_REQUIRED=none"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Start rendering...
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Set job-printer-state-message to "Start rendering...", current level=INFO
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Processing page 1...
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Set job-printer-state-message to "Processing page 1...", current level=INFO
>D [06/Sep/2014:11:39:51 +0100] [Job 72] STATE: +hplip.plugin-error
>D [06/Sep/2014:11:39:51 +0100] [Job 72] prnt/hpcups/HPCupsFilter.cpp 456: m_Job initialization failed with error = 48
>D [06/Sep/2014:11:39:51 +0100] [Job 72] STATE: +connecting-to-device
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PID 20820 (/usr/lib/cups/filter/hpcups) stopped with status 1.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Hint: Try setting the LogLevel to "debug" to find out more.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Processing page 2...
>D [06/Sep/2014:11:39:51 +0100] [Job 72] Rendering completed
>D [06/Sep/2014:11:39:51 +0100] [Job 72] STATE: -connecting-to-device
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PID 20819 (/usr/lib/cups/filter/gstoraster) exited with no errors.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
>D [06/Sep/2014:11:39:51 +0100] [Job 72] ready to print
>D [06/Sep/2014:11:39:51 +0100] [Job 72] PID 20821 (/usr/lib/cups/backend/hp) exited with no errors.
>D [06/Sep/2014:11:39:51 +0100] [Job 72] End of messages
>D [06/Sep/2014:11:39:51 +0100] [Job 72] printer-state=3(idle)
>D [06/Sep/2014:11:39:51 +0100] [Job 72] printer-state-message="ready to print"
>D [06/Sep/2014:11:39:51 +0100] [Job 72] printer-state-reasons=none
>E [06/Sep/2014:11:44:52 +0100] [Job 72] Stopping unresponsive job.

Actions: View

Attachments on bug 1138930: 935004