Hi,
I have a small linux box running as my local file- and printserver and generally print to it by locally filtering using cups and turboprint (I have a version for MacOSX). Printing directly to the server is painfully slow as it is only a via c3 @ 533 Mhz
I've set up a locally filtering queue on my ibook but when printing it does not transfer the results from the turboprint filtering to the printserver, all that arrives is a 1kb file which the prinserver, of course, skips. Here's the log from the server:
D [16/May/2005:14:03:58 +0100] AcceptClient: 5 from 192.168.1.5:631.
D [16/May/2005:14:03:58 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:03:58 +0100] ProcessIPPRequest: 5 status_code=1
D [16/May/2005:14:03:58 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:03:58 +0100] print_job: request file type is application/vnd.cups-raw.
D [16/May/2005:14:03:58 +0100] check_quotas: requesting-user-name = 'remroot'
D [16/May/2005:14:03:58 +0100] print_job: requesting-user-name = 'remroot'
D [16/May/2005:14:03:58 +0100] Adding default job-sheets values "none,none"...
I [16/May/2005:14:03:58 +0100] Adding start banner page "none" to job 179.
I [16/May/2005:14:03:58 +0100] Adding end banner page "none" to job 179.
I [16/May/2005:14:03:58 +0100] Job 179 queued on 'tp0' by 'remroot'.
D [16/May/2005:14:03:58 +0100] Job 179 hold_until = 0
D [16/May/2005:14:03:58 +0100] StartJob(179, 0x808b7e0)
D [16/May/2005:14:03:58 +0100] StartJob() id = 179, file = 0/1
D [16/May/2005:14:03:58 +0100] job-sheets=none,none
D [16/May/2005:14:03:58 +0100] banner_page = 0
D [16/May/2005:14:03:58 +0100] StartJob: argv = "tp0","179","remroot","sdldoc.ps","1","cpi=10 lpi=6 turboprint=bt1x0u0 page-ranges=1-5","/var/spool/cups/d00179-001"
D [16/May/2005:14:03:58 +0100] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [16/May/2005:14:03:58 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [16/May/2005:14:03:58 +0100] StartJob: envp[2]="USER=root"
D [16/May/2005:14:03:58 +0100] StartJob: envp[3]="CHARSET=utf-8"
D [16/May/2005:14:03:58 +0100] StartJob: envp[4]="LANG=de"
D [16/May/2005:14:03:58 +0100] StartJob: envp[5]="PPD=/etc/cups/ppd/tp0.ppd"
D [16/May/2005:14:03:58 +0100] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [16/May/2005:14:03:58 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [16/May/2005:14:03:58 +0100] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [16/May/2005:14:03:58 +0100] StartJob: envp[9]="CONTENT_TYPE=application/vnd.cups-raw"
D [16/May/2005:14:03:58 +0100] StartJob: envp[10]="DEVICE_URI=usb:/dev/usb/lp0"
D [16/May/2005:14:03:58 +0100] StartJob: envp[11]="PRINTER=tp0"
D [16/May/2005:14:03:58 +0100] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [16/May/2005:14:03:58 +0100] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [16/May/2005:14:03:58 +0100] StartJob: envp[14]="CUPS_SERVER=localhost"
D [16/May/2005:14:03:58 +0100] StartJob: envp[15]="IPP_PORT=631"
D [16/May/2005:14:03:58 +0100] StartJob: statusfds = [ 7 9 ]
D [16/May/2005:14:03:58 +0100] StartJob: filterfds[1] = [ 10 -1 ]
D [16/May/2005:14:03:58 +0100] StartJob: backend = "/usr/lib/cups/backend/usb"
D [16/May/2005:14:03:58 +0100] StartJob: filterfds[0] = [ -1 11 ]
D [16/May/2005:14:03:58 +0100] start_process("/usr/lib/cups/backend/usb", 0xbffefeb4, 0xbffef224, 10, 11, 9)
I [16/May/2005:14:03:58 +0100] Started backend /usr/lib/cups/backend/usb (PID 18884) for job 179.
D [16/May/2005:14:03:58 +0100] ProcessIPPRequest: 5 status_code=0
D [16/May/2005:14:03:58 +0100] [Job 179] LPGETSTATUS returned a port status of 18...
D [16/May/2005:14:03:58 +0100] UpdateJob: job 179, file 0 is complete.
D [16/May/2005:14:03:58 +0100] CancelJob: id = 179
D [16/May/2005:14:03:58 +0100] StopJob: id = 179, force = 0
D [16/May/2005:14:03:58 +0100] StopJob: printer state is 3
D [16/May/2005:14:03:59 +0100] CloseClient: 5
By contrast, this is what the log looks like when printing is successful from another machine:
D [16/May/2005:14:13:47 +0100] AcceptClient: 5 from hades.kost:631.
D [16/May/2005:14:13:47 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:13:47 +0100] ProcessIPPRequest: 5 status_code=1
D [16/May/2005:14:13:47 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:13:47 +0100] print_job: request file type is application/vnd.cups-raw.
D [16/May/2005:14:13:47 +0100] check_quotas: requesting-user-name = 'remroot'
D [16/May/2005:14:13:47 +0100] print_job: requesting-user-name = 'remroot'
D [16/May/2005:14:13:47 +0100] Adding default job-sheets values "none,none"...
I [16/May/2005:14:13:47 +0100] Adding start banner page "none" to job 180.
I [16/May/2005:14:13:47 +0100] Adding end banner page "none" to job 180.
I [16/May/2005:14:13:47 +0100] Job 180 queued on 'tp0' by 'remroot'.
D [16/May/2005:14:13:47 +0100] Job 180 hold_until = 0
D [16/May/2005:14:13:47 +0100] StartJob(180, 0x808b7e0)
D [16/May/2005:14:13:47 +0100] StartJob() id = 180, file = 0/1
D [16/May/2005:14:13:47 +0100] job-sheets=none,none
D [16/May/2005:14:13:47 +0100] banner_page = 0
D [16/May/2005:14:13:47 +0100] StartJob: argv = "tp0","180","remroot","sdldoc.ps","1","cpi=10 lpi=6 turboprint=bt1x0u0 Resolution=600x600x1dpi PageSize=A4 MediaType=CanonMattePhotoMP101_4 PageRegion=A4 page-ranges=1-5","/var/spool/cups/d00180-001"
D [16/May/2005:14:13:47 +0100] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [16/May/2005:14:13:47 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [16/May/2005:14:13:47 +0100] StartJob: envp[2]="USER=root"
D [16/May/2005:14:13:47 +0100] StartJob: envp[3]="CHARSET=iso-8859-15"
D [16/May/2005:14:13:47 +0100] StartJob: envp[4]="LANG=en"
D [16/May/2005:14:13:47 +0100] StartJob: envp[5]="PPD=/etc/cups/ppd/tp0.ppd"
D [16/May/2005:14:13:47 +0100] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [16/May/2005:14:13:47 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [16/May/2005:14:13:47 +0100] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [16/May/2005:14:13:47 +0100] StartJob: envp[9]="CONTENT_TYPE=application/vnd.cups-raw"
D [16/May/2005:14:13:47 +0100] StartJob: envp[10]="DEVICE_URI=usb:/dev/usb/lp0"
D [16/May/2005:14:13:47 +0100] StartJob: envp[11]="PRINTER=tp0"
D [16/May/2005:14:13:47 +0100] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [16/May/2005:14:13:47 +0100] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [16/May/2005:14:13:47 +0100] StartJob: envp[14]="CUPS_SERVER=localhost"
D [16/May/2005:14:13:47 +0100] StartJob: envp[15]="IPP_PORT=631"
D [16/May/2005:14:13:47 +0100] StartJob: statusfds = [ 7 9 ]
D [16/May/2005:14:13:47 +0100] StartJob: filterfds[1] = [ 10 -1 ]
D [16/May/2005:14:13:47 +0100] StartJob: backend = "/usr/lib/cups/backend/usb"
D [16/May/2005:14:13:47 +0100] StartJob: filterfds[0] = [ -1 11 ]
D [16/May/2005:14:13:47 +0100] start_process("/usr/lib/cups/backend/usb", 0xbffefeb4, 0xbffef224, 10, 11, 9)
I [16/May/2005:14:13:47 +0100] Started backend /usr/lib/cups/backend/usb (PID 18969) for job 180.
D [16/May/2005:14:13:47 +0100] ProcessIPPRequest: 5 status_code=0
D [16/May/2005:14:13:47 +0100] [Job 180] LPGETSTATUS returned a port status of 18...
D [16/May/2005:14:13:48 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:13:48 +0100] ProcessIPPRequest: 5 status_code=1
D [16/May/2005:14:13:48 +0100] CloseClient: 5
D [16/May/2005:14:19:37 +0100] UpdateJob: job 180, file 0 is complete.
D [16/May/2005:14:19:37 +0100] CancelJob: id = 180
D [16/May/2005:14:19:37 +0100] StopJob: id = 180, force = 0
D [16/May/2005:14:19:37 +0100] StopJob: printer state is 3
I can see from the job log that the size of the job from the macosx machine is just 1Kb...
Does anyone know what's going wrong?
I have a small linux box running as my local file- and printserver and generally print to it by locally filtering using cups and turboprint (I have a version for MacOSX). Printing directly to the server is painfully slow as it is only a via c3 @ 533 Mhz
I've set up a locally filtering queue on my ibook but when printing it does not transfer the results from the turboprint filtering to the printserver, all that arrives is a 1kb file which the prinserver, of course, skips. Here's the log from the server:
D [16/May/2005:14:03:58 +0100] AcceptClient: 5 from 192.168.1.5:631.
D [16/May/2005:14:03:58 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:03:58 +0100] ProcessIPPRequest: 5 status_code=1
D [16/May/2005:14:03:58 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:03:58 +0100] print_job: request file type is application/vnd.cups-raw.
D [16/May/2005:14:03:58 +0100] check_quotas: requesting-user-name = 'remroot'
D [16/May/2005:14:03:58 +0100] print_job: requesting-user-name = 'remroot'
D [16/May/2005:14:03:58 +0100] Adding default job-sheets values "none,none"...
I [16/May/2005:14:03:58 +0100] Adding start banner page "none" to job 179.
I [16/May/2005:14:03:58 +0100] Adding end banner page "none" to job 179.
I [16/May/2005:14:03:58 +0100] Job 179 queued on 'tp0' by 'remroot'.
D [16/May/2005:14:03:58 +0100] Job 179 hold_until = 0
D [16/May/2005:14:03:58 +0100] StartJob(179, 0x808b7e0)
D [16/May/2005:14:03:58 +0100] StartJob() id = 179, file = 0/1
D [16/May/2005:14:03:58 +0100] job-sheets=none,none
D [16/May/2005:14:03:58 +0100] banner_page = 0
D [16/May/2005:14:03:58 +0100] StartJob: argv = "tp0","179","remroot","sdldoc.ps","1","cpi=10 lpi=6 turboprint=bt1x0u0 page-ranges=1-5","/var/spool/cups/d00179-001"
D [16/May/2005:14:03:58 +0100] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [16/May/2005:14:03:58 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [16/May/2005:14:03:58 +0100] StartJob: envp[2]="USER=root"
D [16/May/2005:14:03:58 +0100] StartJob: envp[3]="CHARSET=utf-8"
D [16/May/2005:14:03:58 +0100] StartJob: envp[4]="LANG=de"
D [16/May/2005:14:03:58 +0100] StartJob: envp[5]="PPD=/etc/cups/ppd/tp0.ppd"
D [16/May/2005:14:03:58 +0100] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [16/May/2005:14:03:58 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [16/May/2005:14:03:58 +0100] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [16/May/2005:14:03:58 +0100] StartJob: envp[9]="CONTENT_TYPE=application/vnd.cups-raw"
D [16/May/2005:14:03:58 +0100] StartJob: envp[10]="DEVICE_URI=usb:/dev/usb/lp0"
D [16/May/2005:14:03:58 +0100] StartJob: envp[11]="PRINTER=tp0"
D [16/May/2005:14:03:58 +0100] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [16/May/2005:14:03:58 +0100] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [16/May/2005:14:03:58 +0100] StartJob: envp[14]="CUPS_SERVER=localhost"
D [16/May/2005:14:03:58 +0100] StartJob: envp[15]="IPP_PORT=631"
D [16/May/2005:14:03:58 +0100] StartJob: statusfds = [ 7 9 ]
D [16/May/2005:14:03:58 +0100] StartJob: filterfds[1] = [ 10 -1 ]
D [16/May/2005:14:03:58 +0100] StartJob: backend = "/usr/lib/cups/backend/usb"
D [16/May/2005:14:03:58 +0100] StartJob: filterfds[0] = [ -1 11 ]
D [16/May/2005:14:03:58 +0100] start_process("/usr/lib/cups/backend/usb", 0xbffefeb4, 0xbffef224, 10, 11, 9)
I [16/May/2005:14:03:58 +0100] Started backend /usr/lib/cups/backend/usb (PID 18884) for job 179.
D [16/May/2005:14:03:58 +0100] ProcessIPPRequest: 5 status_code=0
D [16/May/2005:14:03:58 +0100] [Job 179] LPGETSTATUS returned a port status of 18...
D [16/May/2005:14:03:58 +0100] UpdateJob: job 179, file 0 is complete.
D [16/May/2005:14:03:58 +0100] CancelJob: id = 179
D [16/May/2005:14:03:58 +0100] StopJob: id = 179, force = 0
D [16/May/2005:14:03:58 +0100] StopJob: printer state is 3
D [16/May/2005:14:03:59 +0100] CloseClient: 5
By contrast, this is what the log looks like when printing is successful from another machine:
D [16/May/2005:14:13:47 +0100] AcceptClient: 5 from hades.kost:631.
D [16/May/2005:14:13:47 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:13:47 +0100] ProcessIPPRequest: 5 status_code=1
D [16/May/2005:14:13:47 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:13:47 +0100] print_job: request file type is application/vnd.cups-raw.
D [16/May/2005:14:13:47 +0100] check_quotas: requesting-user-name = 'remroot'
D [16/May/2005:14:13:47 +0100] print_job: requesting-user-name = 'remroot'
D [16/May/2005:14:13:47 +0100] Adding default job-sheets values "none,none"...
I [16/May/2005:14:13:47 +0100] Adding start banner page "none" to job 180.
I [16/May/2005:14:13:47 +0100] Adding end banner page "none" to job 180.
I [16/May/2005:14:13:47 +0100] Job 180 queued on 'tp0' by 'remroot'.
D [16/May/2005:14:13:47 +0100] Job 180 hold_until = 0
D [16/May/2005:14:13:47 +0100] StartJob(180, 0x808b7e0)
D [16/May/2005:14:13:47 +0100] StartJob() id = 180, file = 0/1
D [16/May/2005:14:13:47 +0100] job-sheets=none,none
D [16/May/2005:14:13:47 +0100] banner_page = 0
D [16/May/2005:14:13:47 +0100] StartJob: argv = "tp0","180","remroot","sdldoc.ps","1","cpi=10 lpi=6 turboprint=bt1x0u0 Resolution=600x600x1dpi PageSize=A4 MediaType=CanonMattePhotoMP101_4 PageRegion=A4 page-ranges=1-5","/var/spool/cups/d00180-001"
D [16/May/2005:14:13:47 +0100] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [16/May/2005:14:13:47 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [16/May/2005:14:13:47 +0100] StartJob: envp[2]="USER=root"
D [16/May/2005:14:13:47 +0100] StartJob: envp[3]="CHARSET=iso-8859-15"
D [16/May/2005:14:13:47 +0100] StartJob: envp[4]="LANG=en"
D [16/May/2005:14:13:47 +0100] StartJob: envp[5]="PPD=/etc/cups/ppd/tp0.ppd"
D [16/May/2005:14:13:47 +0100] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [16/May/2005:14:13:47 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [16/May/2005:14:13:47 +0100] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [16/May/2005:14:13:47 +0100] StartJob: envp[9]="CONTENT_TYPE=application/vnd.cups-raw"
D [16/May/2005:14:13:47 +0100] StartJob: envp[10]="DEVICE_URI=usb:/dev/usb/lp0"
D [16/May/2005:14:13:47 +0100] StartJob: envp[11]="PRINTER=tp0"
D [16/May/2005:14:13:47 +0100] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [16/May/2005:14:13:47 +0100] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [16/May/2005:14:13:47 +0100] StartJob: envp[14]="CUPS_SERVER=localhost"
D [16/May/2005:14:13:47 +0100] StartJob: envp[15]="IPP_PORT=631"
D [16/May/2005:14:13:47 +0100] StartJob: statusfds = [ 7 9 ]
D [16/May/2005:14:13:47 +0100] StartJob: filterfds[1] = [ 10 -1 ]
D [16/May/2005:14:13:47 +0100] StartJob: backend = "/usr/lib/cups/backend/usb"
D [16/May/2005:14:13:47 +0100] StartJob: filterfds[0] = [ -1 11 ]
D [16/May/2005:14:13:47 +0100] start_process("/usr/lib/cups/backend/usb", 0xbffefeb4, 0xbffef224, 10, 11, 9)
I [16/May/2005:14:13:47 +0100] Started backend /usr/lib/cups/backend/usb (PID 18969) for job 180.
D [16/May/2005:14:13:47 +0100] ProcessIPPRequest: 5 status_code=0
D [16/May/2005:14:13:47 +0100] [Job 180] LPGETSTATUS returned a port status of 18...
D [16/May/2005:14:13:48 +0100] ReadClient: 5 POST /printers/tp0 HTTP/1.1
D [16/May/2005:14:13:48 +0100] ProcessIPPRequest: 5 status_code=1
D [16/May/2005:14:13:48 +0100] CloseClient: 5
D [16/May/2005:14:19:37 +0100] UpdateJob: job 180, file 0 is complete.
D [16/May/2005:14:19:37 +0100] CancelJob: id = 180
D [16/May/2005:14:19:37 +0100] StopJob: id = 180, force = 0
D [16/May/2005:14:19:37 +0100] StopJob: printer state is 3
I can see from the job log that the size of the job from the macosx machine is just 1Kb...
Does anyone know what's going wrong?