Date: Fri, 28 Apr 2006 10:29:51 +1000 From: Malcolm Fitzgerald <thats@notyourhomework.net> To: "P.U.Kruppa" <root@pukruppa.de> Cc: "freebsd-questions@FreeBSD. ORG" <freebsd-questions@freebsd.org> Subject: Re: Help needed compiling printer source code Message-ID: <c7df718a9ba9b3de3664845d3b5ca90c@notyourhomework.net> In-Reply-To: <20060428012135.E1100@www.pukruppa.net> References: <658be17fbe25500c985c5b8fc35ffc95@notyourhomework.net> <20060423091441.M1100@www.pukruppa.net> <499dd1ce422438ea0c0ac99b1f41ce8b@notyourhomework.net> <20060423133640.D1100@www.pukruppa.net> <20060423140319.S1100@www.pukruppa.net> <1209639b8bc7faaeb76ebf0932051131@notyourhomework.net> <20060425191942.P1100@www.pukruppa.net> <544660b49b4b30f3139c0fbebad337ae@notyourhomework.net> <20060426194552.M1100@www.pukruppa.net> <56d68e774a001387e8169bd8638484c7@notyourhomework.net> <20060428012135.E1100@www.pukruppa.net>
next in thread | previous in thread | raw e-mail | index | archive | help
On 28/04/2006, at 9:36 AM, P.U.Kruppa wrote: > On Thu, 27 Apr 2006, Malcolm Fitzgerald wrote: > >> >> On 27/04/2006, at 7:33 AM, P.U.Kruppa wrote: >> >>> On Wed, 26 Apr 2006, Malcolm Fitzgerald wrote: >>>>>> I've set up a printer. >>>>>> location: lpt0 >>>>>> Printer State: idle, accepting jobs >>>>>> device URI: parallel:/dev/lpt0 >>>>>> Printing the test page does not work, the job is aborted with >>>>>> error: client-error-not-possible >>>>> The most probable reason for this is that some user permissions >>>>> are set incorrectly. We have to analyze this step by step. >>>>> 1) Try to print directly from the command line: >>>>> # printf "Hello World \f" > /dev/lpt0 >>>>> If your printer is connected correctly to your parallel port, >>>>> *something* should be printed out. >>>> as user I get "cannot create /dev/lpt0: Permission denied" >>> That is o.k.. You should try to setup your printer as root first >>> anyway: you always can solve problems with lower user permissions >>> later on. >>>> as root I get a blank page >>> So at least your printer can print the form feed character "\f" >>> :-) >>> As Robert Huff suggested in his mail one reason might be wrong >>> permissions of your spooler directory. >>> 2) If you haven't set it otherwise it should be found at >>> /var/spool/cups >>> 3) # cd /var/spool/ >>> # ls -l >>> should show this >>> drwx--x--- 3 root daemon 1536 26 Apr 19:44 cups >>> 4) Inside /var/spool/cups you should find some files with >>> names like >>> c00001 >>> c00002 >>> c00003 >>> and so on, each representing one print job. >> >> >> Yes, I have that. Changing permissions on /var/spool/cups/ to 777 >> hasn't changed things. >> Each time I try to print a test page from the cups "Printers" page >> the job is aborted. >> >> mystified. > O.K. Lets try to have a look at logfiles > Ad the line > LogLevel debug > to your /usr/local/etc/cups/cupsd.conf > and restart cups > # /usr/local/etc/rc.d/cupsd restart > When I print the test page I get this in /var/log/cups/error_log <snip> mine is below. Without knowing anything about this the line that looks odd to me says: D [28/Apr/2006:09:54:37 +1000] [Job 1] /usr/local/libexec/cups/filter/foomatic-rip: No such file or directory ------------------------------------------------------ I [28/Apr/2006:09:45:55 +1000] Listening to 0:631 D [28/Apr/2006:09:45:55 +1000] AddLocation: added location '/' D [28/Apr/2006:09:45:55 +1000] DenyIP: / deny 00000000/00000000 D [28/Apr/2006:09:45:55 +1000] AllowIP: / allow 7f000001/ffffffff D [28/Apr/2006:09:45:55 +1000] AddLocation: added location '/admin' D [28/Apr/2006:09:45:55 +1000] DenyIP: /admin deny 00000000/00000000 D [28/Apr/2006:09:45:55 +1000] AllowIP: /admin allow 7f000001/ffffffff I [28/Apr/2006:09:45:55 +1000] Loaded configuration file "/usr/local/etc/cups/cupsd.conf" I [28/Apr/2006:09:45:55 +1000] Configured for up to 100 clients. I [28/Apr/2006:09:45:55 +1000] Allowing up to 100 client connections per host. I [28/Apr/2006:09:45:55 +1000] Full reload is required. D [28/Apr/2006:09:45:55 +1000] LoadAllPrinters: Loading printer HL1230... D [28/Apr/2006:09:45:55 +1000] LoadDevices: Added device "ipp"... D [28/Apr/2006:09:45:55 +1000] LoadDevices: Added device "lpd"... D [28/Apr/2006:09:45:55 +1000] LoadDevices: Added device "parallel:/dev/lpt0"... D [28/Apr/2006:09:45:55 +1000] LoadDevices: Added device "serial:/dev/ttyd0?baud=115200"... D [28/Apr/2006:09:45:55 +1000] LoadDevices: Added device "serial:/dev/ttyd1?baud=115200"... D [28/Apr/2006:09:45:55 +1000] LoadDevices: Added device "socket"... D [28/Apr/2006:09:45:55 +1000] LoadDevices: Added device "http"... I [28/Apr/2006:09:45:55 +1000] LoadPPDs: Read "/usr/local/etc/cups/ppds.dat", 17 PPDs... I [28/Apr/2006:09:45:55 +1000] LoadPPDs: No new or changed PPDs... D [28/Apr/2006:09:45:55 +1000] LoadAllJobs: Scanning /var/spool/cups... I [28/Apr/2006:09:45:55 +1000] Full reload complete. D [28/Apr/2006:09:45:55 +1000] StartListening: NumListeners=1 D [28/Apr/2006:09:45:55 +1000] StartListening: address=00000000 port=631 D [28/Apr/2006:09:45:55 +1000] ResumeListening: setting input bits... D [28/Apr/2006:09:54:29 +1000] AcceptClient: 5 from localhost:631. D [28/Apr/2006:09:54:29 +1000] ReadClient: 5 GET /printers/HL1230 HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] CGI /usr/local/libexec/cups/cgi-bin/printers.cgi started - PID = 804 I [28/Apr/2006:09:54:29 +1000] Started "/usr/local/libexec/cups/cgi-bin/printers.cgi" (pid=804) D [28/Apr/2006:09:54:29 +1000] SendCommand: 5 file=7 D [28/Apr/2006:09:54:29 +1000] AcceptClient: 8 from localhost:631. D [28/Apr/2006:09:54:29 +1000] ReadClient: 8 POST / HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] ProcessIPPRequest: 8 status_code=1 D [28/Apr/2006:09:54:29 +1000] ReadClient: 8 POST / HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] ProcessIPPRequest: 8 status_code=1 D [28/Apr/2006:09:54:29 +1000] ReadClient: 8 POST / HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] ProcessIPPRequest: 8 status_code=1 D [28/Apr/2006:09:54:29 +1000] CloseClient: 8 D [28/Apr/2006:09:54:29 +1000] AcceptClient: 7 from localhost:631. D [28/Apr/2006:09:54:29 +1000] ReadClient: 7 GET /cups.css HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] SendFile: 7 file=8 D [28/Apr/2006:09:54:29 +1000] ReadClient: 5 GET /images/right.gif HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] SendFile: 5 file=9 D [28/Apr/2006:09:54:29 +1000] AcceptClient: 10 from localhost:631. D [28/Apr/2006:09:54:29 +1000] AcceptClient: 8 from localhost:631. D [28/Apr/2006:09:54:29 +1000] ReadClient: 10 GET /images/navbar.gif HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] SendFile: 10 file=9 D [28/Apr/2006:09:54:29 +1000] ReadClient: 8 GET /images/left.gif HTTP/1.1 D [28/Apr/2006:09:54:29 +1000] SendFile: 8 file=11 D [28/Apr/2006:09:54:30 +1000] ReadClient: 7 GET /images/printer-idle.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 7 file=9 D [28/Apr/2006:09:54:30 +1000] ReadClient: 5 GET /images/print-test-page.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 5 file=9 D [28/Apr/2006:09:54:30 +1000] ReadClient: 8 GET /images/stop-printer.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 8 file=9 D [28/Apr/2006:09:54:30 +1000] ReadClient: 10 GET /images/reject-jobs.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 10 file=9 D [28/Apr/2006:09:54:30 +1000] ReadClient: 7 GET /images/modify-printer.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 7 file=9 D [28/Apr/2006:09:54:30 +1000] ReadClient: 5 GET /images/config-printer.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 5 file=9 D [28/Apr/2006:09:54:30 +1000] ReadClient: 10 GET /images/set-as-default.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 10 file=11 D [28/Apr/2006:09:54:30 +1000] ReadClient: 8 GET /images/delete-printer.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 8 file=12 D [28/Apr/2006:09:54:30 +1000] ReadClient: 7 GET /images/add-printer.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 7 file=9 D [28/Apr/2006:09:54:30 +1000] ReadClient: 5 GET /images/show-completed.gif HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendFile: 5 file=11 D [28/Apr/2006:09:54:30 +1000] AcceptClient: 9 from localhost:631. D [28/Apr/2006:09:54:30 +1000] ReadClient: 9 GET /favicon.ico HTTP/1.1 D [28/Apr/2006:09:54:30 +1000] SendError: 9 code=404 (Not Found) D [28/Apr/2006:09:54:30 +1000] CloseClient: 9 D [28/Apr/2006:09:54:36 +1000] ReadClient: 8 GET /printers/HL1230?op=print-test-page HTTP/1.1 D [28/Apr/2006:09:54:36 +1000] CGI /usr/local/libexec/cups/cgi-bin/printers.cgi started - PID = 809 I [28/Apr/2006:09:54:36 +1000] Started "/usr/local/libexec/cups/cgi-bin/printers.cgi" (pid=809) D [28/Apr/2006:09:54:36 +1000] SendCommand: 8 file=11 D [28/Apr/2006:09:54:37 +1000] AcceptClient: 9 from localhost:631. D [28/Apr/2006:09:54:37 +1000] ReadClient: 9 POST /printers/HL1230 HTTP/1.1 D [28/Apr/2006:09:54:37 +1000] print_job: request file type is application/postscript. D [28/Apr/2006:09:54:37 +1000] check_quotas: requesting-user-name = '' D [28/Apr/2006:09:54:37 +1000] print_job: requesting-user-name = '' D [28/Apr/2006:09:54:37 +1000] Adding default job-sheets values "none,none"... I [28/Apr/2006:09:54:37 +1000] Adding start banner page "none" to job 1. I [28/Apr/2006:09:54:37 +1000] Adding end banner page "none" to job 1. I [28/Apr/2006:09:54:37 +1000] Job 1 queued on 'HL1230' by ''. D [28/Apr/2006:09:54:37 +1000] Job 1 hold_until = 0 D [28/Apr/2006:09:54:37 +1000] StartJob(1, 0x81a4000) D [28/Apr/2006:09:54:37 +1000] StartJob() id = 1, file = 0/1 D [28/Apr/2006:09:54:37 +1000] job-sheets=none,none D [28/Apr/2006:09:54:37 +1000] banner_page = 0 D [28/Apr/2006:09:54:37 +1000] StartJob: argv = "HL1230","1","","Test Page","1","","/var/spool/cups/d00001-001" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[0]="PATH=/usr/local/libexec/cups/filter:/bin:/usr/bin" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[1]="SOFTWARE=CUPS/1.1" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[2]="USER=root" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[3]="CHARSET=utf-8" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[4]="LANG=en" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[5]="PPD=/usr/local/etc/cups/ppd/HL1230.ppd" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[6]="CUPS_SERVERROOT=/usr/local/etc/cups" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[7]="RIP_MAX_CACHE=8m" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[9]="CONTENT_TYPE=application/postscript" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[10]="DEVICE_URI=parallel:/dev/lpt0" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[11]="PRINTER=HL1230" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[12]="CUPS_DATADIR=/usr/local/share/cups" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[13]="CUPS_FONTPATH=/usr/local/share/cups/fonts" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[14]="CUPS_SERVER=localhost" D [28/Apr/2006:09:54:37 +1000] StartJob: envp[15]="IPP_PORT=631" D [28/Apr/2006:09:54:37 +1000] StartJob: statusfds = [ 12 13 ] D [28/Apr/2006:09:54:37 +1000] StartJob: filterfds[1] = [ 14 -1 ] D [28/Apr/2006:09:54:37 +1000] StartJob: filter = "/usr/local/libexec/cups/filter/pstops" D [28/Apr/2006:09:54:37 +1000] StartJob: filterfds[0] = [ 15 16 ] D [28/Apr/2006:09:54:37 +1000] start_process("/usr/local/libexec/cups/filter/pstops", 0xbfbedb60, 0xbfbeced0, 14, 16, 13) I [28/Apr/2006:09:54:37 +1000] Started filter /usr/local/libexec/cups/filter/pstops (PID 810) for job 1. D [28/Apr/2006:09:54:37 +1000] StartJob: filter = "/usr/local/libexec/cups/filter/foomatic-rip" D [28/Apr/2006:09:54:37 +1000] StartJob: filterfds[1] = [ 14 17 ] D [28/Apr/2006:09:54:37 +1000] start_process("/usr/local/libexec/cups/filter/foomatic-rip", 0xbfbedb60, 0xbfbeced0, 15, 17, 13) I [28/Apr/2006:09:54:37 +1000] Started filter /usr/local/libexec/cups/filter/foomatic-rip (PID 811) for job 1. D [28/Apr/2006:09:54:37 +1000] StartJob: backend = "/usr/local/libexec/cups/backend/parallel" D [28/Apr/2006:09:54:37 +1000] StartJob: filterfds[0] = [ -1 15 ] D [28/Apr/2006:09:54:37 +1000] start_process("/usr/local/libexec/cups/backend/parallel", 0xbfbedb60, 0xbfbeced0, 14, 15, 13) I [28/Apr/2006:09:54:37 +1000] Started backend /usr/local/libexec/cups/backend/parallel (PID 812) for job 1. D [28/Apr/2006:09:54:37 +1000] ProcessIPPRequest: 9 status_code=0 E [28/Apr/2006:09:54:37 +1000] PID 811 stopped with status 2! D [28/Apr/2006:09:54:37 +1000] [Job 1] /usr/local/libexec/cups/filter/foomatic-rip: No such file or directory D [28/Apr/2006:09:54:37 +1000] CloseClient: 9 D [28/Apr/2006:09:54:37 +1000] [Job 1] Page = 595x842; 0,0 to 595,842 D [28/Apr/2006:09:54:37 +1000] [Job 1] slowcollate=0, slowduplex=0, sloworder=0 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%BoundingBox: 0 0 612 792 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%Pages: 1 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%LanguageLevel: 1 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%DocumentData: Clean7Bit D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%DocumentSuppliedResources: procset testprint/1.1 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%Creator: Michael Sweet, Easy Software Products D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%CreationDate: May 11, 1999 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%Title: Test Page D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%EndComments D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%BeginProlog D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%BeginResource procset testprint 1.1 0 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%EndResource D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%EndProlog D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%Page: 1 1 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%Page: 1 1 D [28/Apr/2006:09:54:37 +1000] [Job 1] pw = 595.0, pl = 842.0 D [28/Apr/2006:09:54:37 +1000] [Job 1] PageLeft = 0.0, PageRight = 595.0 D [28/Apr/2006:09:54:37 +1000] [Job 1] PageTop = 842.0, PageBottom = 0.0 D [28/Apr/2006:09:54:37 +1000] [Job 1] PageWidth = 595.0, PageLength = 842.0 D [28/Apr/2006:09:54:37 +1000] [Job 1] 0 %%EOF D [28/Apr/2006:09:54:37 +1000] [Job 1] Saw EOF! D [28/Apr/2006:09:54:37 +1000] UpdateJob: job 1, file 0 is complete. D [28/Apr/2006:09:54:37 +1000] CancelJob: id = 1 D [28/Apr/2006:09:54:37 +1000] StopJob: id = 1, force = 0 D [28/Apr/2006:09:54:37 +1000] StopJob: printer state is 3 D [28/Apr/2006:09:54:40 +1000] ReadClient: 5 GET /printers/HL1230 HTTP/1.1 D [28/Apr/2006:09:54:40 +1000] CGI /usr/local/libexec/cups/cgi-bin/printers.cgi started - PID = 813 I [28/Apr/2006:09:54:40 +1000] Started "/usr/local/libexec/cups/cgi-bin/printers.cgi" (pid=813) D [28/Apr/2006:09:54:40 +1000] SendCommand: 5 file=11 D [28/Apr/2006:09:54:40 +1000] AcceptClient: 9 from localhost:631. D [28/Apr/2006:09:54:40 +1000] ReadClient: 9 POST / HTTP/1.1 D [28/Apr/2006:09:54:40 +1000] ProcessIPPRequest: 9 status_code=1 D [28/Apr/2006:09:54:40 +1000] ReadClient: 9 POST / HTTP/1.1 D [28/Apr/2006:09:54:40 +1000] ProcessIPPRequest: 9 status_code=1 D [28/Apr/2006:09:54:40 +1000] ReadClient: 9 POST / HTTP/1.1 D [28/Apr/2006:09:54:40 +1000] ProcessIPPRequest: 9 status_code=1 D [28/Apr/2006:09:54:40 +1000] CloseClient: 9 D [28/Apr/2006:09:54:45 +1000] ReadClient: 7 GET /printers/HL1230?which_jobs=completed HTTP/1.1 D [28/Apr/2006:09:54:45 +1000] CGI /usr/local/libexec/cups/cgi-bin/printers.cgi started - PID = 814 I [28/Apr/2006:09:54:45 +1000] Started "/usr/local/libexec/cups/cgi-bin/printers.cgi" (pid=814) D [28/Apr/2006:09:54:45 +1000] SendCommand: 7 file=11 D [28/Apr/2006:09:54:45 +1000] AcceptClient: 9 from localhost:631. D [28/Apr/2006:09:54:45 +1000] ReadClient: 9 POST / HTTP/1.1 D [28/Apr/2006:09:54:45 +1000] ProcessIPPRequest: 9 status_code=1 D [28/Apr/2006:09:54:45 +1000] ReadClient: 9 POST / HTTP/1.1 D [28/Apr/2006:09:54:45 +1000] ProcessIPPRequest: 9 status_code=1 D [28/Apr/2006:09:54:45 +1000] ReadClient: 9 POST / HTTP/1.1 D [28/Apr/2006:09:54:45 +1000] ProcessIPPRequest: 9 status_code=1 D [28/Apr/2006:09:54:45 +1000] CloseClient: 9 D [28/Apr/2006:09:54:45 +1000] ReadClient: 5 GET /images/restart-job.gif HTTP/1.1 D [28/Apr/2006:09:54:45 +1000] SendFile: 5 file=9 D [28/Apr/2006:09:54:45 +1000] ReadClient: 8 GET /images/show-active.gif HTTP/1.1 D [28/Apr/2006:09:54:45 +1000] SendFile: 8 file=11 D [28/Apr/2006:09:55:31 +1000] CloseClient: 10 D [28/Apr/2006:09:55:46 +1000] CloseClient: 7 D [28/Apr/2006:09:55:46 +1000] CloseClient: 5 D [28/Apr/2006:09:55:46 +1000] CloseClient: 8 D [28/Apr/2006:09:57:34 +1000] AcceptClient: 5 from localhost:631. D [28/Apr/2006:09:57:34 +1000] ReadClient: 5 POST /printers/ HTTP/1.1 D [28/Apr/2006:09:57:34 +1000] ProcessIPPRequest: 5 status_code=1 D [28/Apr/2006:09:57:34 +1000] CloseClient: 5 D [28/Apr/2006:09:57:34 +1000] AcceptClient: 5 from localhost:631. D [28/Apr/2006:09:57:34 +1000] ReadClient: 5 POST /classes/ HTTP/1.1 D [28/Apr/2006:09:57:34 +1000] ProcessIPPRequest: 5 status_code=1 D [28/Apr/2006:09:57:34 +1000] CloseClient: 5 D [28/Apr/2006:09:57:34 +1000] AcceptClient: 5 from localhost:631. D [28/Apr/2006:09:57:34 +1000] ReadClient: 5 POST /printers/ HTTP/1.1 D [28/Apr/2006:09:57:34 +1000] ProcessIPPRequest: 5 status_code=1 D [28/Apr/2006:09:57:34 +1000] CloseClient: 5 -- malcolm
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?c7df718a9ba9b3de3664845d3b5ca90c>