Canon Pixma MP500 - lp won't work

Anonymous anonymous at easysw.com
Mon Apr 17 05:08:43 PDT 2006


Hello,

I'm trying to configure my brand new Canon Pixma MP500.

I installed drivers on gentoo using this thread: http://forums.gentoo.org/viewtopic-t-448354-highlight-pixma.html.

Cups perfectly detected my printer and "Print Test Page" works.

Unfortunately, while trying to configure Firefox to be able to print, I discovered the lp command doesn't work.

Here is the diagnostic:

( Trying to print the test page using lp with cups in debug level traces):

thierry at titine ~ $ lp -d MP500 /usr/share/cups/data/testprint.ps
request id is MP500-16 (1 file(s))

State on CUPS Jobs admin: Aborted
When tring to "restart job": client-error-not-possible

Here are the Error logs in debug mode with the command issue.
Obious error: E [17/Apr/2006:12:53:24 +0100] PID 14587 stopped with status 0!

==> error_log <==
D [17/Apr/2006:12:53:24 +0100] AcceptClient: 5 from localhost:631.
D [17/Apr/2006:12:53:24 +0100] ReadClient: 5 POST / HTTP/1.1
D [17/Apr/2006:12:53:24 +0100] ProcessIPPRequest: 5 status_code=1
D [17/Apr/2006:12:53:24 +0100] ReadClient: 5 POST / HTTP/1.1
D [17/Apr/2006:12:53:24 +0100] ProcessIPPRequest: 5 status_code=1
D [17/Apr/2006:12:53:24 +0100] ReadClient: 5 POST / HTTP/1.1
D [17/Apr/2006:12:53:24 +0100] ProcessIPPRequest: 5 status_code=0
D [17/Apr/2006:12:53:24 +0100] AcceptClient: 7 from localhost:631.
D [17/Apr/2006:12:53:24 +0100] CloseClient: 5
D [17/Apr/2006:12:53:24 +0100] ReadClient: 7 POST /printers/MP500 HTTP/1.1
D [17/Apr/2006:12:53:24 +0100] print_job: auto-typing file...
D [17/Apr/2006:12:53:24 +0100] print_job: request file type is application/postscript.
D [17/Apr/2006:12:53:24 +0100] check_quotas: requesting-user-name = 'thierry'
D [17/Apr/2006:12:53:24 +0100] print_job: requesting-user-name = 'thierry'
I [17/Apr/2006:12:53:24 +0100] Adding start banner page "none" to job 16.
I [17/Apr/2006:12:53:24 +0100] Adding end banner page "none" to job 16.
I [17/Apr/2006:12:53:24 +0100] Job 16 queued on 'MP500' by 'thierry'.
D [17/Apr/2006:12:53:24 +0100] Job 16 hold_until = 0
D [17/Apr/2006:12:53:24 +0100] StartJob(16, 0x8094f28)
D [17/Apr/2006:12:53:24 +0100] StartJob() id = 16, file = 0/1
D [17/Apr/2006:12:53:24 +0100] job-sheets=none,none
D [17/Apr/2006:12:53:24 +0100] banner_page = 0
D [17/Apr/2006:12:53:24 +0100] StartJob: argv = "MP500","16","thierry","testprint.ps","1","outputorder=normal number-up=1 nowrap position=top-left ColorModel=rgb Resolution=600 CNQuality=3 MediaType=plain PageRegion=a4 InputSlot=asf","/var/spool/cups/d00016-001"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[2]="USER=root"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[3]="CHARSET=iso-8859-1"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[4]="LANG=en"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[5]="PPD=/etc/cups/ppd/MP500.ppd"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[9]="CONTENT_TYPE=application/postscript"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[10]="DEVICE_URI=usb:/dev/usb/lp0"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[11]="PRINTER=MP500"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[14]="CUPS_SERVER=localhost"
D [17/Apr/2006:12:53:24 +0100] StartJob: envp[15]="IPP_PORT=631"
D [17/Apr/2006:12:53:24 +0100] StartJob: statusfds = [ 5 8 ]
D [17/Apr/2006:12:53:24 +0100] StartJob: filterfds[1] = [ 9 -1 ]
D [17/Apr/2006:12:53:24 +0100] StartJob: filter = "/usr/lib/cups/filter/pstops"
D [17/Apr/2006:12:53:24 +0100] StartJob: filterfds[0] = [ 10 11 ]
D [17/Apr/2006:12:53:24 +0100] start_process("/usr/lib/cups/filter/pstops", 0xbf8647e0, 0xbf863b50, 9, 11, 8)
I [17/Apr/2006:12:53:24 +0100] Started filter /usr/lib/cups/filter/pstops (PID 14586) for job 16.
D [17/Apr/2006:12:53:24 +0100] StartJob: filter = "/usr/lib/cups/filter/pstocanonbj"
D [17/Apr/2006:12:53:24 +0100] StartJob: filterfds[1] = [ 9 12 ]
D [17/Apr/2006:12:53:24 +0100] start_process("/usr/lib/cups/filter/pstocanonbj", 0xbf8647e0, 0xbf863b50, 10, 12, 8)
I [17/Apr/2006:12:53:24 +0100] Started filter /usr/lib/cups/filter/pstocanonbj (PID 14587) for job 16.
D [17/Apr/2006:12:53:24 +0100] StartJob: backend = "/usr/lib/cups/backend/usb"
D [17/Apr/2006:12:53:24 +0100] StartJob: filterfds[0] = [ -1 10 ]
D [17/Apr/2006:12:53:24 +0100] start_process("/usr/lib/cups/backend/usb", 0xbf8647e0, 0xbf863b50, 9, 10, 8)
I [17/Apr/2006:12:53:24 +0100] Started backend /usr/lib/cups/backend/usb (PID 14588) for job 16.
D [17/Apr/2006:12:53:24 +0100] ProcessIPPRequest: 7 status_code=0
E [17/Apr/2006:12:53:24 +0100] PID 14587 stopped with status 0!
D [17/Apr/2006:12:53:24 +0100] [Job 16] Page = 595x842; 10,14 to 586,833
D [17/Apr/2006:12:53:24 +0100] [Job 16] slowcollate=0, slowduplex=0, sloworder=0
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%BoundingBox: 0 0 612 792
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%Pages: 1
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%LanguageLevel: 1
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%DocumentData: Clean7Bit
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%DocumentSuppliedResources: procset testprint/1.1
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%Creator: Michael Sweet, Easy Software Products
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%CreationDate: May 11, 1999
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%Title: Test Page
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%EndComments
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%BeginProlog
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%BeginResource procset testprint 1.1 0
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%EndResource
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%EndProlog
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%Page: 1 1
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%Page: 1 1
D [17/Apr/2006:12:53:24 +0100] [Job 16] pw = 576.0, pl = 819.2
D [17/Apr/2006:12:53:24 +0100] [Job 16] PageLeft = 9.6, PageRight = 585.6
D [17/Apr/2006:12:53:24 +0100] [Job 16] PageTop = 833.4, PageBottom = 14.2
D [17/Apr/2006:12:53:24 +0100] [Job 16] PageWidth = 595.0, PageLength = 842.0
D [17/Apr/2006:12:53:24 +0100] [Job 16] 0 %%EOF
D [17/Apr/2006:12:53:24 +0100] [Job 16] Saw EOF!
D [17/Apr/2006:12:53:24 +0100] [Job 16] pstocanonbj start.
D [17/Apr/2006:12:53:24 +0100] CloseClient: 7
D [17/Apr/2006:12:53:24 +0100] [Job 16] LPGETSTATUS returned a port status of 18...
D [17/Apr/2006:12:53:24 +0100] UpdateJob: job 16, file 0 is complete.
D [17/Apr/2006:12:53:24 +0100] CancelJob: id = 16
D [17/Apr/2006:12:53:24 +0100] StopJob: id = 16, force = 0
D [17/Apr/2006:12:53:24 +0100] StopJob: printer state is 3



And the working "test page" using the GUI button:
==> error_log <==
D [17/Apr/2006:12:56:02 +0100] AcceptClient: 5 from localhost:631.
D [17/Apr/2006:12:56:02 +0100] ReadClient: 5 GET /printers/MP500?op=print-test-page HTTP/1.1
D [17/Apr/2006:12:56:02 +0100] CGI /usr/lib/cups/cgi-bin/printers.cgi started - PID = 14591
I [17/Apr/2006:12:56:02 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=14591)
D [17/Apr/2006:12:56:02 +0100] SendCommand: 5 file=8
D [17/Apr/2006:12:56:02 +0100] AcceptClient: 7 from localhost:631.
D [17/Apr/2006:12:56:02 +0100] ReadClient: 7 POST /printers/MP500 HTTP/1.1
D [17/Apr/2006:12:56:02 +0100] print_job: request file type is application/postscript.
D [17/Apr/2006:12:56:02 +0100] check_quotas: requesting-user-name = 'root'
D [17/Apr/2006:12:56:02 +0100] print_job: requesting-user-name = 'root'
D [17/Apr/2006:12:56:02 +0100] Adding default job-sheets values "none,none"...
I [17/Apr/2006:12:56:02 +0100] Adding start banner page "none" to job 17.
I [17/Apr/2006:12:56:02 +0100] Adding end banner page "none" to job 17.
I [17/Apr/2006:12:56:02 +0100] Job 17 queued on 'MP500' by 'root'.
D [17/Apr/2006:12:56:02 +0100] Job 17 hold_until = 0
D [17/Apr/2006:12:56:02 +0100] StartJob(17, 0x8094f28)
D [17/Apr/2006:12:56:02 +0100] StartJob() id = 17, file = 0/1
D [17/Apr/2006:12:56:02 +0100] job-sheets=none,none
D [17/Apr/2006:12:56:02 +0100] banner_page = 0
D [17/Apr/2006:12:56:02 +0100] StartJob: argv = "MP500","17","root","Test Page","1","","/var/spool/cups/d00017-001"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[2]="USER=root"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[3]="CHARSET=utf-8"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[4]="LANG=en_US"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[5]="PPD=/etc/cups/ppd/MP500.ppd"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[9]="CONTENT_TYPE=application/postscript"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[10]="DEVICE_URI=usb:/dev/usb/lp0"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[11]="PRINTER=MP500"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[14]="CUPS_SERVER=localhost"
D [17/Apr/2006:12:56:02 +0100] StartJob: envp[15]="IPP_PORT=631"
D [17/Apr/2006:12:56:02 +0100] StartJob: statusfds = [ 9 10 ]
D [17/Apr/2006:12:56:02 +0100] StartJob: filterfds[1] = [ 11 -1 ]
D [17/Apr/2006:12:56:02 +0100] StartJob: filter = "/usr/lib/cups/filter/pstops"
D [17/Apr/2006:12:56:02 +0100] StartJob: filterfds[0] = [ 12 13 ]
D [17/Apr/2006:12:56:02 +0100] start_process("/usr/lib/cups/filter/pstops", 0xbf8647e0, 0xbf863b50, 11, 13, 10)
I [17/Apr/2006:12:56:02 +0100] Started filter /usr/lib/cups/filter/pstops (PID 14592) for job 17.
D [17/Apr/2006:12:56:02 +0100] StartJob: filter = "/usr/lib/cups/filter/pstocanonbj"
D [17/Apr/2006:12:56:02 +0100] StartJob: filterfds[1] = [ 11 14 ]
D [17/Apr/2006:12:56:02 +0100] start_process("/usr/lib/cups/filter/pstocanonbj", 0xbf8647e0, 0xbf863b50, 12, 14, 10)
I [17/Apr/2006:12:56:02 +0100] Started filter /usr/lib/cups/filter/pstocanonbj (PID 14593) for job 17.
D [17/Apr/2006:12:56:02 +0100] StartJob: backend = "/usr/lib/cups/backend/usb"
D [17/Apr/2006:12:56:02 +0100] StartJob: filterfds[0] = [ -1 12 ]
D [17/Apr/2006:12:56:02 +0100] start_process("/usr/lib/cups/backend/usb", 0xbf8647e0, 0xbf863b50, 11, 12, 10)
I [17/Apr/2006:12:56:02 +0100] Started backend /usr/lib/cups/backend/usb (PID 14597) for job 17.
D [17/Apr/2006:12:56:02 +0100] ProcessIPPRequest: 7 status_code=0
D [17/Apr/2006:12:56:02 +0100] [Job 17] Page = 595x842; 10,14 to 586,833
D [17/Apr/2006:12:56:02 +0100] [Job 17] slowcollate=0, slowduplex=0, sloworder=0
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%BoundingBox: 0 0 612 792
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%Pages: 1
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%LanguageLevel: 1
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%DocumentData: Clean7Bit
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%DocumentSuppliedResources: procset testprint/1.1
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%Creator: Michael Sweet, Easy Software Products
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%CreationDate: May 11, 1999
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%Title: Test Page
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%EndComments
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%BeginProlog
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%BeginResource procset testprint 1.1 0
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%EndResource
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%EndProlog
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%Page: 1 1
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%Page: 1 1
D [17/Apr/2006:12:56:02 +0100] [Job 17] pw = 576.0, pl = 819.2
D [17/Apr/2006:12:56:02 +0100] [Job 17] PageLeft = 9.6, PageRight = 585.6
D [17/Apr/2006:12:56:02 +0100] [Job 17] PageTop = 833.4, PageBottom = 14.2
D [17/Apr/2006:12:56:02 +0100] [Job 17] PageWidth = 595.0, PageLength = 842.0
D [17/Apr/2006:12:56:02 +0100] [Job 17] 0 %%EOF
D [17/Apr/2006:12:56:02 +0100] [Job 17] Saw EOF!
D [17/Apr/2006:12:56:02 +0100] [Job 17] pstocanonbj start.
D [17/Apr/2006:12:56:02 +0100] [Job 17] pstocanonbj: /usr/bin/gs -r600 -g4958x7016 -q -dNOPROMPT -dSAFER -sDEVICE=ppmraw -sOutputFile=- -| /usr/local/bin/bjfilterpixusip4100 --imageres 600 --papersize a4 --media plain --paperload cassette --quality 3 --bbox 9,14,585,834
D [17/Apr/2006:12:56:02 +0100] CloseClient: 7
D [17/Apr/2006:12:56:02 +0100] [Job 17] LPGETSTATUS returned a port status of 18...
D [17/Apr/2006:12:56:20 +0100] UpdateJob: job 17, file 0 is complete.
D [17/Apr/2006:12:56:20 +0100] CancelJob: id = 17
D [17/Apr/2006:12:56:20 +0100] StopJob: id = 17, force = 0
D [17/Apr/2006:12:56:20 +0100] StopJob: printer state is 3







More information about the cups mailing list