TurboPrint & PrintFab

TurboPrint 2.2 has stopped working on OpenSuse 11.4 with my Pixma MP830, possibly with the update from 11.3 to 11.4. Can you suggest a method for debugging?

Hello jschwatzman,

can you please give some more details about what "stopped working" means? What did you try, what worked what does not work? Any error messages in TurboPrint Monitor?

Jobs show up in the monitor as 'stopped'. They can't be restarted and they never reach the printer. The monitor does not display any error messages. The printer is attached to a Windows box and is accessed by TurboPrint as a cifs share.

I have tried reinstalling TurboPrint 2.2. The problem persisted.

I found the following in /var/lib/cups/error_log:
E [28/Apr/2011:15:55:20 -0400] [Job 44] Stopping job because the sheduler could not execute the backend.
E [28/Apr/2011:15:56:24 -0400] [Job 43] Stopping unresponsive job!
E [28/Apr/2011:15:56:44 -0400] Unable to execute /usr/lib/cups/backend/smb: insecure file permissions (0104750)

This is not a TurboPrint specific problem but a problem within the Linux printing system "CUPS":

The file /usr/lib/cups/backend/smb must be owned by root and must not be writeable by group or others.
The following terminal commands should fix the problem:

sudo chown root /usr/lib/cups/backend/smb
sudo chmod 755 /usr/lib/cups/backend/smb

The following document contains details on this topic:

http://www.cups.org/documentation.php/api-filter.html

OK. I've done that. Now, when I bring up the monitor and try to print a test page, it shows 'pending' and 'no active jobs'.
tp0 is shown as stopped. Hitting Start/Stop job toggles from 'pending' to 'held'.
If I click on 'accept jobs', the monitor locks up.

To start the printer again you can also enter the following command in a terminal window

sudo /usr/sbin/cupsenable printername

where <printername> is the printer queue name as visible in TurboPrint Control or TurboPrint Monitor.

If that doesn't help, remove jobs from TurboPrint Monitor and reboot.

sudo /usr/sbin/cupsenable tp0 changes 'Stopped' to 'Idle' in the TP monitor, but printing a test page fails with the following log output. (Also, clicking on 'Accept Jobs' still locks up the TP monitor.


tail -f /var/log/cups/error_log
D [12/May/2011:11:13:09 -0400] [Job 66] Wrote 1 pages...
D [12/May/2011:11:13:09 -0400] [Job 66] TurboPrint: printing page 1, 0% complete...
D [12/May/2011:11:13:09 -0400] [Job 66] /usr/lib/cups/filter/pstoturboprint: line 54: kill: (7161) - No such process
D [12/May/2011:11:13:09 -0400] [Job 66] /usr/lib/cups/filter/pstoturboprint: line 74: kill: (7161) - No such process
D [12/May/2011:11:13:09 -0400] [Job 66] Backend returned status -11 (crashed)
D [12/May/2011:11:13:09 -0400] [Job 66] Printer stopped due to backend errors; please consult the error_log file for details.
D [12/May/2011:11:13:09 -0400] [Job 66] End of messages
D [12/May/2011:11:13:09 -0400] [Job 66] printer-state=5(stopped)
D [12/May/2011:11:13:09 -0400] [Job 66] printer-state-message="TurboPrint: printing page 1, 0% complete..."
D [12/May/2011:11:13:09 -0400] [Job 66] printer-state-reasons=paused
E [12/May/2011:11:14:22 -0400] PID 7184 (/usr/lib/cups/backend/smb) crashed on signal 11!
D [12/May/2011:11:14:25 -0400] [Job 66] The following messages were recorded from 11:14:22 to 11:14:25
D [12/May/2011:11:14:25 -0400] [Job 66] job-sheets=none,none
D [12/May/2011:11:14:25 -0400] [Job 66] argv[0]="tp0"
D [12/May/2011:11:14:25 -0400] [Job 66] argv[1]="66"
D [12/May/2011:11:14:25 -0400] [Job 66] argv[2]="js"
D [12/May/2011:11:14:25 -0400] [Job 66] argv[3]="TurboPrint Testpage"
D [12/May/2011:11:14:25 -0400] [Job 66] argv[4]="1"
D [12/May/2011:11:14:25 -0400] [Job 66] argv[5]="columns=1 cpi=10 Duplex=DuplexNoTumble finishings=3 InputSlot=ButtonSelect lpi=8 media=Letter MediaType=Plainpaper_4 number-up=1 PageRegion=Letter PageSize=Letter prettyprint Resolution=600x600dpi sides=two-sided-long-edge zedoAdjustC=0 zedoAdjustK=0 zedoAdjustM=0 zedoAdjustY=0 zedoBorderlessExpand=2 zedoBrightC=0 zedoBrightM=0 zedoBrightness=0 zedoCMYKspace=0 zedoColorModel=RGB zedoColorspace=0 zedoContrast=0 zedoDithering=ErrorDiffusion zedoDuplexAdjust=1 zedoDuplexadvanced=auto zedoGamut=0 zedoGreyToneA=0 zedoGreyToneB=0 zedoInklimitC=0 zedoInklimitK=0 zedoInklimitM=0 zedoInklimitY=0 zedoIntensity=0 zedoIntent=perception_0 zedoMirror=0 zedoPreview=preview-off zedoRefLight=65 zedoShadows=0 zedoTAC=0 zedoUCR=0 zedoUserColor=0 job-uuid=urn:uuid:ec5a98c5-7f41-3c1e-71ae-33943600af19 job-originating-host-name=localhost time-at-creation=1305212680 time-at-processing=1305213262"
D [12/May/2011:11:14:25 -0400] [Job 66] argv[6]="/var/spool/cups/d00066-001"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[8]="HOME=/var/spool/cups/tmp"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[10]="SERVER_ADMIN=root@Intrepid"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[11]="SOFTWARE=CUPS/1.4.6"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[13]="USER=root"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[16]="IPP_PORT=631"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[17]="CHARSET=utf-8"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[18]="LANG=en_US.UTF-8"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[19]="PPD=/etc/cups/ppd/tp0.ppd"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[20]="RIP_MAX_CACHE=128m"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[21]="CONTENT_TYPE=application/postscript"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[22]="DEVICE_URI=smb://Forte/Wombat/MP830"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[23]="PRINTER_INFO=Canon_PIXMA_MP830"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[24]="PRINTER_LOCATION="
D [12/May/2011:11:14:25 -0400] [Job 66] envp[25]="PRINTER=tp0"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[26]="CUPS_FILETYPE=document"
D [12/May/2011:11:14:25 -0400] [Job 66] envp[27]="FINAL_CONTENT_TYPE=printer/tp0"
D [12/May/2011:11:14:25 -0400] [Job 66] Started filter /usr/lib/cups/filter/pstops (PID 7182)
D [12/May/2011:11:14:25 -0400] [Job 66] Started filter /usr/lib/cups/filter/pstoturboprint (PID 7183)
D [12/May/2011:11:14:25 -0400] [Job 66] Started backend /usr/lib/cups/backend/smb (PID 7184)
D [12/May/2011:11:14:25 -0400] [Job 66] Page = 612x792; 18,14 to 594,784
D [12/May/2011:11:14:25 -0400] [Job 66] slow_collate=0, slow_duplex=0, slow_order=0
D [12/May/2011:11:14:25 -0400] [Job 66] Before copy_comments - %!PS-Adobe-3.0
D [12/May/2011:11:14:25 -0400] [Job 66] %!PS-Adobe-3.0
D [12/May/2011:11:14:25 -0400] [Job 66] %%Title: testgfx_letter.cdr
D [12/May/2011:11:14:25 -0400] [Job 66] %%Creator: CorelDRAW 10
D [12/May/2011:11:14:25 -0400] [Job 66] %%CreationDate: Tue May 28 17:32:34 2002
D [12/May/2011:11:14:25 -0400] [Job 66] %%BoundingBox: 0 0 612 792
D [12/May/2011:11:14:25 -0400] [Job 66] %%LanguageLevel: 2
D [12/May/2011:11:14:25 -0400] [Job 66] %%DocumentProcessColors: (atend)
D [12/May/2011:11:14:25 -0400] [Job 66] %%DocumentSuppliedResources: (atend)
D [12/May/2011:11:14:25 -0400] [Job 66] %%Pages: (atend)
D [12/May/2011:11:14:25 -0400] [Job 66] %%EndComments
D [12/May/2011:11:14:25 -0400] [Job 66] Before copy_prolog - %%BeginProlog
D [12/May/2011:11:14:25 -0400] [Job 66] Before copy_setup - %%BeginSetup
D [12/May/2011:11:14:25 -0400] [Job 66] Before page loop - %%Page: 1 1
D [12/May/2011:11:14:25 -0400] [Job 66] Copying page 1...
D [12/May/2011:11:14:25 -0400] [Job 66] pagew = 576.0, pagel = 769.1
D [12/May/2011:11:14:25 -0400] [Job 66] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [12/May/2011:11:14:25 -0400] [Job 66] PageLeft = 18.0, PageRight = 594.0
D [12/May/2011:11:14:25 -0400] [Job 66] PageTop = 783.5, PageBottom = 14.4
D [12/May/2011:11:14:25 -0400] [Job 66] PageWidth = 612.0, PageLength = 792.0
D [12/May/2011:11:14:25 -0400] [Job 66] Wrote 1 pages...
D [12/May/2011:11:14:25 -0400] [Job 66] TurboPrint: printing page 1, 0% complete...
D [12/May/2011:11:14:25 -0400] [Job 66] /usr/lib/cups/filter/pstoturboprint: line 54: kill: (7204) - No such process
D [12/May/2011:11:14:25 -0400] [Job 66] /usr/lib/cups/filter/pstoturboprint: line 74: kill: (7204) - No such process
D [12/May/2011:11:14:25 -0400] [Job 66] Backend returned status -11 (crashed)
D [12/May/2011:11:14:25 -0400] [Job 66] Printer stopped due to backend errors; please consult the error_log file for details.
D [12/May/2011:11:14:25 -0400] [Job 66] End of messages
D [12/May/2011:11:14:25 -0400] [Job 66] printer-state=5(stopped)
D [12/May/2011:11:14:25 -0400] [Job 66] printer-state-message="TurboPrint: printing page 1, 0% complete..."
D [12/May/2011:11:14:25 -0400] [Job 66] printer-state-reasons=paused

Please respond with any suggestions:

tail -f /var/log/cups/error_log
D [12/May/2011:11:13:09 -0400] [Job 66] Wrote 1 pages...
D [12/May/2011:11:13:09 -0400] [Job 66] TurboPrint: printing page 1, 0% complete...
D [12/May/2011:11:13:09 -0400] [Job 66] /usr/lib/cups/filter/pstoturboprint: line 54: kill: (7161) - No such process
D [12/May/2011:11:13:09 -0400] [Job 66] /usr/lib/cups/filter/pstoturboprint: line 74: kill: (7161) - No such process
D [12/May/2011:11:13:09 -0400] [Job 66] Backend returned status -11 (crashed)
D [12/May/2011:11:13:09 -0400] [Job 66] Printer stopped due to backend errors; please consult the error_log file for details.
D [12/May/2011:11:13:09 -0400] [Job 66] End of messages

I just noticed that /sbin/yast2 is hanging when I go to the hardware | printer configuration screen. This is an AMD x86_64 system.

This is the end of the output of /var/log/turboprint/print.log when trying to print a test page:

Colormatch file=PGI5CLI8; Curves=600dpi_quick_plain_ip4200; Table=plain_paper
Report at end of pdrive_class::begin_page
Total memory usage=1212937
PREVIEW y_offset=70 org_height=6600 src_scanline=70 preview_scanline=6
calculate_dim: print left=0 top=0 width=4800 height=6409
calculate_dim: section left=150 top=70 width=4800 height=6409
check_add_logo returned 0
Printed section of picture:
left=150 top=70 width=4800 height=6409
Printer: resolution x_dpi=600 y_dpi=600 color_mode=2
Page - printable area in printer pixels:
left=150 top=70 width=4800 height=6409
Print size in printer pixels, relative to printable area:
left=0 top=0 width=4800 height=6409
------------ End of print job - result = 141 ------------
job cancelling procedure - TPPID=9601 GSPID=9603 PVPID=
------------ END of tpprint filter ------------

Your printer is configured as a "Windows network printer" and the Linux network printing backend "smb" that transfers data to the Windows printer server fails:

D [12/May/2011:11:14:25 -0400] [Job 66] Backend returned status -11 (crashed)
D [12/May/2011:11:14:25 -0400] [Job 66] Printer stopped due to backend errors; please consult the error_log file for details.

This is not a TurboPrint driver problem but a general Linux network printing problem - you will not be able to print to a Windows printer server using any other printer driver.

It might help to update or re-install the package "samba". You can also look for help in one of the other Linux forums.