Printing issues

I am having trouble with a Starr TSP100LAN that I have installed. OpenVPMS is running in tomcat7 on ubuntu 14.04LTS and I have the cups-bsd package installed.

The printer works fine with a test print through the cups interface and I can print OK to it using reports or using forms that are generated with libreoffice.

When I try to print an invoice or receipt though it fails. No error gets displayed it just gets stuck in the queue. The job stops with a "Filter failed" message.

What is the difference between printing from the reports screen or printing an invoice? They are both jasper-reports so I would think it would fail in both or work in both. Does the print job come from a different user? or in a different format?

Matt Y.  

 

 

 

Comment viewing options

Select your preferred way to display the comments and click "Save settings" to activate your changes.

Re: Printing issues

Can you get any more information from the CUPS error log?

 

Re: Printing issues

D [17/Mar/2015:10:11:08 +1100] Get-Printer-Attributes ipp://localhost/printers/TSP100
D [17/Mar/2015:10:11:08 +1100] [Client 19] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/TSP100) from localhost
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetArray: printer_uri_supported[0]="/printers/TSP100"
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetArray: printer_name[0]="TSP100"
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetArray: printer_make_and_model[0]="Star TSP100 Cutter"
D [17/Mar/2015:10:11:08 +1100] Get-Jobs ipp://localhost:631/printers/TSP100
D [17/Mar/2015:10:11:08 +1100] [Client 19] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/TSP100) from localhost
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetVariable: TITLE="TSP100"
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetVariable: PRINTER_NAME="TSP100"
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED="/printers/TSP100"
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetVariable: THISURL="/printers/TSP100"
D [17/Mar/2015:10:11:08 +1100] [CGI] cgiSetVariable: SEARCH_DEST="TSP100"
D [17/Mar/2015:10:11:26 +1100] Get-Printer-Attributes ipp://localhost:631/printers/TSP100
D [17/Mar/2015:10:11:26 +1100] [Client 19] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/TSP100) from localhost
D [17/Mar/2015:10:11:26 +1100] [Client 19] POST /printers/TSP100 HTTP/1.1
D [17/Mar/2015:10:11:26 +1100] Create-Job ipp://localhost:631/printers/TSP100
I [17/Mar/2015:10:11:26 +1100] [Job 2357] Queued on "TSP100" by "tomcat7".
D [17/Mar/2015:10:11:26 +1100] [Client 19] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/TSP100) from localhost
D [17/Mar/2015:10:11:26 +1100] [Client 19] POST /printers/TSP100 HTTP/1.1
D [17/Mar/2015:10:11:26 +1100] Send-Document ipp://localhost:631/printers/TSP100
D [17/Mar/2015:10:11:26 +1100] [Job 2357] rastertostar (application/vnd.cups-raster to printer/TSP100, cost 0)
D [17/Mar/2015:10:11:26 +1100] [Job 2357] argv[0]="TSP100"
D [17/Mar/2015:10:11:26 +1100] [Job 2357] envp[20]="PPD=/etc/cups/ppd/TSP100.ppd"
D [17/Mar/2015:10:11:26 +1100] [Job 2357] envp[26]="PRINTER=TSP100"
D [17/Mar/2015:10:11:26 +1100] [Job 2357] envp[29]="FINAL_CONTENT_TYPE=printer/TSP100"
D [17/Mar/2015:10:11:26 +1100] [Client 19] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/TSP100) from localhost
D [17/Mar/2015:10:11:26 +1100] [Job 2357] PPD: /etc/cups/ppd/TSP100.ppd
D [17/Mar/2015:10:11:33 +1100] [Client 8] GET /printers/TSP100 HTTP/1.1
D [17/Mar/2015:10:11:33 +1100] [CGI] envp[26] = "SCRIPT_NAME=/printers/TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc-root/printers/TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] envp[28] = "PATH_INFO=/TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] envp[33] = "HTTP_REFERER=https://192.168.1.30:631/printers/TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetVariable: PRINTER_NAME="TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] show_printer(http=0x7fcc464ba1c0, printer=TSP100")
D [17/Mar/2015:10:11:33 +1100] Get-Printer-Attributes ipp://localhost/printers/TSP100
D [17/Mar/2015:10:11:33 +1100] [Client 22] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/TSP100) from localhost
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetArray: printer_uri_supported[0]="/printers/TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetArray: printer_name[0]="TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetArray: printer_make_and_model[0]="Star TSP100 Cutter"
D [17/Mar/2015:10:11:33 +1100] Get-Jobs ipp://localhost:631/printers/TSP100
D [17/Mar/2015:10:11:33 +1100] [Client 22] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/TSP100) from localhost
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetVariable: TITLE="TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetArray: job_printer_name[0]="TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetArray: job_printer_uri[0]="/printersTSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetVariable: PRINTER_NAME="TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED="/printers/TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetVariable: THISURL="/printers/TSP100"
D [17/Mar/2015:10:11:33 +1100] [CGI] cgiSetVariable: SEARCH_DEST="TSP100"
D [17/Mar/2015:10:11:35 +1100] [Client 8] GET /printers/TSP100 HTTP/1.1
D [17/Mar/2015:10:11:35 +1100] [CGI] envp[26] = "SCRIPT_NAME=/printers/TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc-root/printers/TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] envp[28] = "PATH_INFO=/TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] envp[33] = "HTTP_REFERER=https://192.168.1.30:631/printers/TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetVariable: PRINTER_NAME="TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] show_printer(http=0x7fe1630171c0, printer=TSP100")
D [17/Mar/2015:10:11:35 +1100] Get-Printer-Attributes ipp://localhost/printers/TSP100
D [17/Mar/2015:10:11:35 +1100] [Client 22] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/TSP100) from localhost
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetArray: printer_uri_supported[0]="/printers/TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetArray: printer_name[0]="TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetArray: printer_make_and_model[0]="Star TSP100 Cutter"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetVariable: TITLE="TSP100"
D [17/Mar/2015:10:11:35 +1100] Get-Jobs ipp://localhost:631/printers/TSP100
D [17/Mar/2015:10:11:35 +1100] [Client 22] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/TSP100) from localhost
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetArray: job_printer_name[0]="TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetArray: job_printer_uri[0]="/printersTSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetVariable: PRINTER_NAME="TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetVariable: PRINTER_URI_SUPPORTED="/printers/TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetVariable: THISURL="/printers/TSP100"
D [17/Mar/2015:10:11:35 +1100] [CGI] cgiSetVariable: SEARCH_DEST="TSP100"

Re: Printing issues

Do you have any logs that show the error?

Re: Printing issues

D [26/Mar/2015:10:25:14 +1100] [Job 2662] pstopdf 6 args: 2662 tomcat7 JasperReports - invoice 1 finishings=3 number-up=1 job-uuid=urn:uuid:5b374308-05b7-38c9-42f1-a98b3671a3b1 job-originating-host-name=localhost time-at-creation=1427325914 time-at-processing=1427325914 /var/spool/cups/d02662-001

D [26/Mar/2015:10:25:14 +1100] [Job 2662] PPD: /etc/cups/ppd/TSP100.ppd

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] STATE: +connecting-to-device

D [26/Mar/2015:10:25:14 +1100] cupsdMarkDirty(---J-)

D [26/Mar/2015:10:25:14 +1100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"

D [26/Mar/2015:10:25:14 +1100] Discarding unused printer-state-changed event...

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] pageType = 0

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] Looking up "192.168.1.41"...

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] backendWaitLoop(snmp_fd=5, addr=0x7f0a58505c28, side_cb=0x7f0a57e0d200)

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] focusArea = -1

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] printSpeed = 0

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] topSearch = -1

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] pageCutType = 0

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] docCutType = 1

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] cashDrawerSetting = 0

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] cashDrawer1PulseWidth = 2

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] peripheralSetting = -1

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] peripheralActionPulseWidth = -1

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] presenterAction = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] presenterTimeout = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] mediaType = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] labelDetect = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] printDensity = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] snoutControl = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] snout1Interval = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] snout2Interval = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] bytesPerScanLine = 72

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer1Setting = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer1OnTime = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer1OffTime = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer1Repeat = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer2Setting = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer2OnTime = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer2OffTime = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] buzzer2Repeat = 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] documentTopSound = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] documentBottomSound = -1

D [26/Mar/2015:10:25:14 +1100] [Job 2662] dataTreatmentRecoverFromError = -1

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] Resolution: 

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] Orientation requested: 0

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] Page size: X72MMY200MM

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] Width: 204, height: 566, absolute margins: 0.0, 0.0, 204.0, 566.0

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] Relative margins: 0.0, 0.0, 0, 0

D [26/Mar/2015:10:25:14 +1100] [Job 2662] PPD options: -dDEVICEWIDTHPOINTS=204 -dDEVICEHEIGHTPOINTS=566

D [26/Mar/2015:10:25:14 +1100] [Job 2662] PostScript to be injected: <</.HWMargins[0.0 0.0 0 0] /Margins[0 0]>>setpagedevice

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:14 +1100] [Job 2662] 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=204 -dDEVICEHEIGHTPOINTS=566 -sOutputFile=-  -c <</.HWMargins[0.0 0.0 0 0] /Margins[0 0]>>setpagedevice .setpdfwrite -f -

D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:15 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] Segmentation fault (core dumped)

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] PID 4819 (/usr/lib/cups/filter/pstopdf) stopped with status 139 (Directory not empty)

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

E [26/Mar/2015:10:25:18 +1100] [Job 2662] loadFile failed: temp file: not a PDF file

D [26/Mar/2015:10:25:18 +1100] Discarding unused job-progress event...

D [26/Mar/2015:10:25:18 +1100] Discarding unused printer-state-changed event...

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

E [26/Mar/2015:10:25:18 +1100] [Job 2662] Can't detect file type

E [26/Mar/2015:10:25:18 +1100] [Job 2662] No pages found!

D [26/Mar/2015:10:25:18 +1100] [Job 2662] Connecting to 192.168.1.41:9100

I [26/Mar/2015:10:25:18 +1100] [Job 2662] Connecting to printer.

D [26/Mar/2015:10:25:18 +1100] Discarding unused job-progress event...

D [26/Mar/2015:10:25:18 +1100] Discarding unused printer-state-changed event...

D [26/Mar/2015:10:25:18 +1100] [Job 2662] PID 4820 (/usr/lib/cups/filter/pdftopdf) stopped with status 1.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] PID 4821 (/usr/lib/cups/filter/gstoraster) stopped with status 1.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] PID 4823 (/usr/lib/cups/filter/rastertostar) stopped with status 1.

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] STATE: -connecting-to-device

D [26/Mar/2015:10:25:18 +1100] cupsdMarkDirty(---J-)

D [26/Mar/2015:10:25:18 +1100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"

I [26/Mar/2015:10:25:18 +1100] [Job 2662] Connected to printer.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] Connected to 192.168.1.41:9100...

D [26/Mar/2015:10:25:18 +1100] [Job 2662] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x7f0a58505c28, use_bc=1, side_cb=0x7f0a57e0d200)

I [26/Mar/2015:10:25:18 +1100] [Job 2662] Waiting for printer to finish.

D [26/Mar/2015:10:25:18 +1100] Discarding unused job-progress event...

D [26/Mar/2015:10:25:18 +1100] Discarding unused printer-state-changed event...

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] Received 11 bytes of back-channel data

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:18 +1100] [Job 2662] PID 4824 (/usr/lib/cups/backend/socket) exited with no errors.

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:18 +1100] Discarding unused job-state-changed event...

E [26/Mar/2015:10:25:18 +1100] [Job 2662] Job stopped due to filter errors; please consult the error_log file for details.

D [26/Mar/2015:10:25:18 +1100] cupsdMarkDirty(---J-)

D [26/Mar/2015:10:25:18 +1100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"

D [26/Mar/2015:10:25:18 +1100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"

D [26/Mar/2015:10:25:18 +1100] Discarding unused printer-state-changed event...

D [26/Mar/2015:10:25:18 +1100] cupsd is not idle any more, canceling shutdown.

D [26/Mar/2015:10:25:19 +1100] [Job 2662] Unloading...

Re: Printing issues

The relevant section appears to be:

D [26/Mar/2015:10:25:14 +1100] [Job 2662] 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=204 -dDEVICEHEIGHTPOINTS=566 -sOutputFile=-  -c <</.HWMargins[0.0 0.0 0 0] /Margins[0 0]>>setpagedevice .setpdfwrite -f -
D [26/Mar/2015:10:25:14 +1100] cupsd is not idle any more, canceling shutdown.
D [26/Mar/2015:10:25:15 +1100] cupsd is not idle any more, canceling shutdown.
D [26/Mar/2015:10:25:18 +1100] [Job 2662] Segmentation fault (core dumped)

so possibly ghostscript is the issue. Can you update it?

 

 

Re: Printing issues

Thankyou Tim,

I upgraded ghostscript from the 9.10 version in 14.04LTS to to the 9.14 version in 14.10 and this resolved the issue.

Thanks,

Matt.

 

 

Syndicate content