From owner-freebsd-questions@FreeBSD.ORG Sun Jul 2 14:53:18 2006 Return-Path: X-Original-To: freebsd-questions@freebsd.org Delivered-To: freebsd-questions@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id 82FD716A403 for ; Sun, 2 Jul 2006 14:53:18 +0000 (UTC) (envelope-from rainer.heesen@gmx.de) Received: from mail.gmx.net (mail.gmx.de [213.165.64.21]) by mx1.FreeBSD.org (Postfix) with SMTP id 0E33A43D45 for ; Sun, 2 Jul 2006 14:53:16 +0000 (GMT) (envelope-from rainer.heesen@gmx.de) Received: (qmail invoked by alias); 02 Jul 2006 14:53:14 -0000 Received: from pD9E8366C.dip0.t-ipconnect.de (EHLO desktop.heesen-bonn.de) [217.232.54.108] by mail.gmx.net (mp019) with SMTP; 02 Jul 2006 16:53:14 +0200 X-Authenticated: #514428 From: Rainer Heesen To: freebsd-questions@freebsd.org Date: Sun, 2 Jul 2006 16:53:13 +0200 User-Agent: KMail/1.9.3 MIME-Version: 1.0 Content-Type: Multipart/Mixed; boundary="Boundary-00=_Z39pEKal4wYc5nb" Message-Id: <200607021653.13546.rainer.heesen@gmx.de> X-Y-GMX-Trusted: 0 Subject: cups 1.2 - no output X-BeenThere: freebsd-questions@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: User questions List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Sun, 02 Jul 2006 14:53:18 -0000 --Boundary-00=_Z39pEKal4wYc5nb Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 7bit Content-Disposition: inline Dear all after upgrading to cups 1.2, my printer doesn't print anymore. There is no output. I read the thread concerning cups & permission denied and added the file /etc.devfs.rules. My printer is a Konica Minolta Pagepro 1300 W, that has an usb as well as a parallel interface. First, I tried to use the parallel port. The cups log file says that the job is ok, but the printer doen't print (see attachted logfile parallel.txt). Then I called parallel directly and I received an error: /usr/local/libexec/cups/backend/parallel 21 guest "test" 1 /etc/hosts STATE: +connecting-to-device INFO: Printer not connected; will retry in 30 seconds... ^C My second approach was to use the usb interface. I installed cups with the backend patch from Jan-Espen Pettersen. Here I get these error messages: system default destination: Minolta printer Minolta now printing Minolta-53. enabled since Sun Jul 2 16:27:24 2006 USB port busy; will retry in 30 seconds... scheduler is running system default destination: Minolta device for Minolta: usb:/dev/ulpt0 Minolta accepting requests since Sun Jul 2 16:27:24 2006 printer Minolta now printing Minolta-53. enabled since Sun Jul 2 16:27:24 2006 USB port busy; will retry in 30 seconds... Minolta-53 rainer 346112 Sun Jul 2 16:27:24 2006 The printer works fine under windows. So, I think it's a software problem. Do you have any hint for me? Kind regards Rainer --Boundary-00=_Z39pEKal4wYc5nb Content-Type: text/plain; charset="us-ascii"; name="parallel.txt" Content-Transfer-Encoding: 7bit Content-Disposition: attachment; filename="parallel.txt" D [29/Jun/2006:22:40:52 +0200] [Job 40] Sending job to queue tagged as raw... D [29/Jun/2006:22:40:52 +0200] Discarding unused printer-state-changed event... D [29/Jun/2006:22:40:52 +0200] job-sheets=none,none D [29/Jun/2006:22:40:52 +0200] banner_page = 0 D [29/Jun/2006:22:40:52 +0200] [Job 40] argv[0]="Minolta" D [29/Jun/2006:22:40:52 +0200] [Job 40] argv[1]="40" D [29/Jun/2006:22:40:52 +0200] [Job 40] argv[2]="rainer" D [29/Jun/2006:22:40:52 +0200] [Job 40] argv[3]="Firefox Central | Mozilla Corporation" D [29/Jun/2006:22:40:52 +0200] [Job 40] argv[4]="1" D [29/Jun/2006:22:40:52 +0200] [Job 40] argv[5]="job-uuid=urn:uuid:b33b3ad1-0131-3c40-78a7-f0e8d7e3c253" D [29/Jun/2006:22:40:52 +0200] [Job 40] argv[6]="/var/spool/cups/d00040-001" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[1]="CUPS_DATADIR=/usr/local/share/cups" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[2]="CUPS_DOCROOT=/usr/local/share/doc/cups" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[3]="CUPS_FONTPATH=/usr/local/share/cups/fonts" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[5]="CUPS_SERVERBIN=/usr/local/libexec/cups" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[6]="CUPS_SERVERROOT=/usr/local/etc/cups" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[7]="CUPS_STATEDIR=/var/run/cups" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[8]="PATH=/usr/local/libexec/cups/filter:/usr/local/bin:/usr/local/sbin:/bin:/usr/bin" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[9]="SERVER_ADMIN=root@desktop.heesen-bonn.de" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[10]="SOFTWARE=CUPS/1.2.0" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[11]="TMPDIR=/var/spool/cups/tmp" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[12]="USER=root" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[13]="CUPS_SERVER=/var/run/cups.sock" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[14]="CUPS_ENCRYPTION=IfRequested" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[15]="IPP_PORT=631" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[16]="CHARSET=utf-8" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[17]="LANG=en_US" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[18]="PPD=/usr/local/etc/cups/ppd/Minolta.ppd" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[19]="RIP_MAX_CACHE=8m" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[20]="CONTENT_TYPE=application/postscript" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[21]="DEVICE_URI=parallel:/dev/lpt0" D [29/Jun/2006:22:40:52 +0200] [Job 40] envp[22]="PRINTER=Minolta" d [29/Jun/2006:22:40:52 +0200] start_job: status_pipes = [ 11 12 ] d [29/Jun/2006:22:40:52 +0200] start_job: filterfds[1] = [ 13 -1 ] d [29/Jun/2006:22:40:52 +0200] start_job: backend="/usr/local/libexec/cups/backend/parallel" d [29/Jun/2006:22:40:52 +0200] start_job: filterfds[0] = [ -1 14 ] d [29/Jun/2006:22:40:52 +0200] cupsdStartProcess("/usr/local/libexec/cups/backend/parallel", 0x80dc1c0, 0xbfbeb4b0, 13, 14, 12) I [29/Jun/2006:22:40:52 +0200] Started backend /usr/local/libexec/cups/backend/parallel (PID 1327) for job 40. d [29/Jun/2006:22:40:52 +0200] start_job: Closing print pipes [ -1 -1 ]... d [29/Jun/2006:22:40:52 +0200] start_job: Closing back pipes [ 9 10 ]... d [29/Jun/2006:22:40:52 +0200] start_job: Closing status output pipe 12... d [29/Jun/2006:22:40:52 +0200] start_job: Closing filter pipes for slot 0 [ -1 14 ]... d [29/Jun/2006:22:40:52 +0200] start_job: Adding fd 11 to InputSet... D [29/Jun/2006:22:40:52 +0200] Discarding unused job-state event... D [29/Jun/2006:22:40:52 +0200] cupsdProcessIPPRequest: 7 status_code=0 (successful-ok) d [29/Jun/2006:22:40:52 +0200] cupsdProcessIPPRequest: Adding fd 7 to OutputSet... d [29/Jun/2006:22:40:52 +0200] cupsdWriteClient: 7 bytes < 0 d [29/Jun/2006:22:40:52 +0200] cupsdWriteClient: Removing fd 7 from OutputSet... d [29/Jun/2006:22:40:52 +0200] [Job 40] STATE: +connecting-to-device d [29/Jun/2006:22:40:52 +0200] [Job 40] STATE: -connecting-to-device d [29/Jun/2006:22:40:52 +0200] [Job 40] PAGE: 1 1 D [29/Jun/2006:22:40:52 +0200] Discarding unused job-progress event... I [29/Jun/2006:22:40:52 +0200] [Job 40] Sending print file, 8192 bytes... I [29/Jun/2006:22:40:52 +0200] [Job 40] Sending print file, 16384 bytes... I [29/Jun/2006:22:40:52 +0200] [Job 40] Sending print file, 24576 bytes... I [29/Jun/2006:22:40:52 +0200] [Job 40] Sending print file, 32768 bytes... I [29/Jun/2006:22:40:52 +0200] [Job 40] Sending print file, 40960 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 49152 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 57344 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 65536 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 73728 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 81920 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 90112 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 98304 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 106496 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 114688 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 122880 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 131072 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 139264 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 147456 bytes... I [29/Jun/2006:22:40:53 +0200] [Job 40] Sending print file, 155648 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 163840 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 172032 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 180224 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 188416 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 196608 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 204800 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 212992 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 221184 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 229376 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 237568 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 245760 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 253952 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 262144 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 270336 bytes... I [29/Jun/2006:22:40:54 +0200] [Job 40] Sending print file, 278528 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 286720 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 294912 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 303104 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 311296 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 319488 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 327680 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 335872 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 344064 bytes... I [29/Jun/2006:22:40:55 +0200] [Job 40] Sending print file, 345749 bytes... d [29/Jun/2006:22:40:55 +0200] process_children() D [29/Jun/2006:22:40:55 +0200] PID 1327 (/usr/local/libexec/cups/backend/parallel) exited with no errors. D [29/Jun/2006:22:40:55 +0200] [Job 40] File 0 is complete. d [29/Jun/2006:22:40:55 +0200] cupsdFinishJob: job->status is 0 d [29/Jun/2006:22:40:55 +0200] cupsdFinishJob: Removing fd 11 from InputSet... d [29/Jun/2006:22:40:55 +0200] cupsdFinishJob: Closing status pipes [ 11 -1 ]... D [29/Jun/2006:22:40:55 +0200] Discarding unused job-completed event... d [29/Jun/2006:22:40:55 +0200] cupsdCancelJob: id = 40 d [29/Jun/2006:22:40:55 +0200] cupsdStopJob: id = 40, force = 0 D [29/Jun/2006:22:40:55 +0200] Discarding unused printer-state-changed event... d [29/Jun/2006:22:40:55 +0200] cupsdStopJob: printer state is 3 d [29/Jun/2006:22:40:55 +0200] cupsdStopJob: Closing print pipes [ -1 -1 ]... d [29/Jun/2006:22:40:55 +0200] cupsdStopJob: Closing back pipes [ -1 -1 ]... d [29/Jun/2006:22:40:55 +0200] cupsdSaveJob(job=0x80ac300(40)): job->attrs=0x80cc0c0 d [29/Jun/2006:22:40:55 +0200] cupsdSaveJob(job=0x80ac300(40)): job->attrs=0x80cc0c0 d [29/Jun/2006:22:40:55 +0200] cupsdCheckJobs: 0 active jobs, sleeping=0, reload=0 d [29/Jun/2006:22:40:56 +0200] select_timeout: 31 seconds to send browse update --Boundary-00=_Z39pEKal4wYc5nb Content-Type: text/plain; charset="us-ascii"; name="usb.txt" Content-Transfer-Encoding: 7bit Content-Disposition: attachment; filename="usb.txt" D [02/Jul/2006:16:27:24 +0200] Print-Job ipp://localhost/printers/Minolta d [02/Jul/2006:16:27:24 +0200] print_job(0x80d4000[7], ipp://localhost/printers/Minolta) D [02/Jul/2006:16:27:24 +0200] print_job: auto-typing file... D [02/Jul/2006:16:27:24 +0200] print_job: request file type is application/postscript. d [02/Jul/2006:16:27:24 +0200] add_job(0x80d4000[7], ipp://localhost/printers/Minolta) d [02/Jul/2006:16:27:24 +0200] cupsdFindPolicyOp(p=0x8094640, op=2(Print-Job)) d [02/Jul/2006:16:27:24 +0200] cupsdFindPolicyOp: Found wildcard match... d [02/Jul/2006:16:27:24 +0200] cupsdIsAuthorized: con->uri="/printers/Minolta", con->best=0x809eec0((null)) d [02/Jul/2006:16:27:24 +0200] cupsdIsAuthorized: level=AUTH_ANON, type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0 d [02/Jul/2006:16:27:24 +0200] cupsdIsAuthorized: op=0(unknown-0000) d [02/Jul/2006:16:27:24 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW... d [02/Jul/2006:16:27:24 +0200] check_quotas(0x80d4000[7], 0x80a6000[Minolta]) D [02/Jul/2006:16:27:24 +0200] add_job: requesting-user-name="rainer" I [02/Jul/2006:16:27:24 +0200] Adding start banner page "none" to job 53. d [02/Jul/2006:16:27:24 +0200] copy_banner(0x80d4000[7], 0x80ac400[53], none) d [02/Jul/2006:16:27:24 +0200] add_job_state_reasons(0x80d4000[7], 53) D [02/Jul/2006:16:27:24 +0200] Discarding unused job-created event... d [02/Jul/2006:16:27:24 +0200] add_file(con=0x80d4000[7], job=53, filetype=application/postscript, compression=0) I [02/Jul/2006:16:27:24 +0200] Job 53 queued on "Minolta" by "rainer". D [02/Jul/2006:16:27:24 +0200] Job 53 hold_until = 0 d [02/Jul/2006:16:27:24 +0200] cupsdSaveJob(job=0x80ac400(53)): job->attrs=0x80c9100 d [02/Jul/2006:16:27:24 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0, reload=0 d [02/Jul/2006:16:27:24 +0200] cupsdCheckJobs: Job 53: state_value=3, loaded=yes d [02/Jul/2006:16:27:24 +0200] start_job: id = 53, file = 0/1 D [02/Jul/2006:16:27:24 +0200] [Job 53] Sending job to queue tagged as raw... D [02/Jul/2006:16:27:24 +0200] Discarding unused printer-state-changed event... D [02/Jul/2006:16:27:24 +0200] job-sheets=none,none D [02/Jul/2006:16:27:24 +0200] banner_page = 0 D [02/Jul/2006:16:27:24 +0200] [Job 53] argv[0]="Minolta" D [02/Jul/2006:16:27:24 +0200] [Job 53] argv[1]="53" D [02/Jul/2006:16:27:24 +0200] [Job 53] argv[2]="rainer" D [02/Jul/2006:16:27:24 +0200] [Job 53] argv[3]="Firefox Central | Mozilla Corporation" D [02/Jul/2006:16:27:24 +0200] [Job 53] argv[4]="1" D [02/Jul/2006:16:27:24 +0200] [Job 53] argv[5]="job-uuid=urn:uuid:60b94c00-86e2-37e0-70ce-717b98e4ac9a" D [02/Jul/2006:16:27:24 +0200] [Job 53] argv[6]="/var/spool/cups/d00053-001" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[1]="CUPS_DATADIR=/usr/local/share/cups" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[2]="CUPS_DOCROOT=/usr/local/share/doc/cups" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[3]="CUPS_FONTPATH=/usr/local/share/cups/fonts" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[5]="CUPS_SERVERBIN=/usr/local/libexec/cups" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[6]="CUPS_SERVERROOT=/usr/local/etc/cups" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[7]="CUPS_STATEDIR=/var/run/cups" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[8]="PATH=/usr/local/libexec/cups/filter:/usr/local/bin:/usr/local/sbin:/bin:/usr/bin" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[9]="SERVER_ADMIN=root@desktop.heesen-bonn.de" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[10]="SOFTWARE=CUPS/1.2.0" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[11]="TMPDIR=/var/spool/cups/tmp" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[12]="USER=root" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[13]="CUPS_SERVER=/var/run/cups.sock" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[14]="CUPS_ENCRYPTION=IfRequested" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[15]="IPP_PORT=631" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[16]="CHARSET=utf-8" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[17]="LANG=en_US" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[18]="PPD=/usr/local/etc/cups/ppd/Minolta.ppd" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[19]="RIP_MAX_CACHE=8m" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[20]="CONTENT_TYPE=application/postscript" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[21]="DEVICE_URI=usb:/dev/ulpt0" D [02/Jul/2006:16:27:24 +0200] [Job 53] envp[22]="PRINTER=Minolta" d [02/Jul/2006:16:27:24 +0200] start_job: status_pipes = [ 11 12 ] d [02/Jul/2006:16:27:24 +0200] start_job: filterfds[1] = [ 13 -1 ] d [02/Jul/2006:16:27:24 +0200] start_job: backend="/usr/local/libexec/cups/backend/usb" d [02/Jul/2006:16:27:24 +0200] start_job: filterfds[0] = [ -1 14 ] d [02/Jul/2006:16:27:24 +0200] cupsdStartProcess("/usr/local/libexec/cups/backend/usb", 0x80dc1a0, 0xbfbeb4b0, 13, 14, 12) I [02/Jul/2006:16:27:24 +0200] Started backend /usr/local/libexec/cups/backend/usb (PID 1337) for job 53. d [02/Jul/2006:16:27:24 +0200] start_job: Closing print pipes [ -1 -1 ]... d [02/Jul/2006:16:27:24 +0200] start_job: Closing back pipes [ 9 10 ]... d [02/Jul/2006:16:27:24 +0200] start_job: Closing status output pipe 12... d [02/Jul/2006:16:27:24 +0200] start_job: Closing filter pipes for slot 0 [ -1 14 ]... d [02/Jul/2006:16:27:24 +0200] start_job: Adding fd 11 to InputSet... D [02/Jul/2006:16:27:24 +0200] Discarding unused job-state event... D [02/Jul/2006:16:27:24 +0200] cupsdProcessIPPRequest: 7 status_code=0 (successful-ok) d [02/Jul/2006:16:27:24 +0200] cupsdProcessIPPRequest: Adding fd 7 to OutputSet... d [02/Jul/2006:16:27:24 +0200] cupsdWriteClient: 7 bytes < 0 d [02/Jul/2006:16:27:24 +0200] cupsdWriteClient: Removing fd 7 from OutputSet... d [02/Jul/2006:16:27:24 +0200] [Job 53] STATE: +connecting-to-device d [02/Jul/2006:16:27:25 +0200] select_timeout: 11 seconds to process active jobs d [02/Jul/2006:16:27:36 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0, reload=0 d [02/Jul/2006:16:27:36 +0200] cupsdCheckJobs: Job 53: state_value=5, loaded=yes d [02/Jul/2006:16:27:36 +0200] select_timeout: 11 seconds to process active jobs I [02/Jul/2006:16:27:40 +0200] [Job 53] USB port busy; will retry in 30 seconds... d [02/Jul/2006:16:27:41 +0200] select_timeout: 11 seconds to process active jobs d [02/Jul/2006:16:27:41 +0200] cupsdAcceptClient(lis=0x809b800) 0 Clients = 1 D [02/Jul/2006:16:27:41 +0200] cupsdAcceptClient: 9 from localhost:631 (IPv6) d [02/Jul/2006:16:27:41 +0200] cupsdAcceptClient: 9 connected to server on localhost:631 d [02/Jul/2006:16:27:41 +0200] cupsdAcceptClient: Adding fd 9 to InputSet... d [02/Jul/2006:16:27:41 +0200] cupsdReadClient: 9, used=0, file=-1 state=0 D [02/Jul/2006:16:27:41 +0200] cupsdReadClient: 9 GET / HTTP/1.1 D [02/Jul/2006:16:27:41 +0200] cupsdReadClient: 9 Browser asked for language "de.utf-8"... d [02/Jul/2006:16:27:41 +0200] cupsdFindBest: uri = "/"... d [02/Jul/2006:16:27:41 +0200] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0 d [02/Jul/2006:16:27:41 +0200] cupsdFindBest: Location /admin/conf Limit 7f d [02/Jul/2006:16:27:41 +0200] cupsdFindBest: Location /admin Limit 7f d [02/Jul/2006:16:27:41 +0200] cupsdFindBest: Location / Limit 7f d [02/Jul/2006:16:27:41 +0200] cupsdFindBest: best = / d [02/Jul/2006:16:27:41 +0200] cupsdAuthorize: con->uri="/", con->best=0x809e340(/) d [02/Jul/2006:16:27:41 +0200] cupsdAuthorize: Authorization="" D [02/Jul/2006:16:27:41 +0200] cupsdAuthorize: No authentication data provided. d [02/Jul/2006:16:27:41 +0200] cupsdIsAuthorized: con->uri="/", con->best=0x809e340(/) d [02/Jul/2006:16:27:41 +0200] cupsdIsAuthorized: level=AUTH_ANON, type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0 d [02/Jul/2006:16:27:41 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW... d [02/Jul/2006:16:27:42 +0200] get_file: 9 filename=/usr/local/share/doc/cups/index.html size=5725 d [02/Jul/2006:16:27:42 +0200] is_cgi(con=0x80e1000, filename="/usr/local/share/doc/cups/index.html", filestats=0xbfbf2430, type=text/html) d [02/Jul/2006:16:27:42 +0200] is_cgi: Returning 0... D [02/Jul/2006:16:27:42 +0200] write_file: 9 file=10 d [02/Jul/2006:16:27:42 +0200] write_file: Adding fd 9 to OutputSet... d [02/Jul/2006:16:27:42 +0200] cupsdWriteClient: Read 5725 bytes from file 10... d [02/Jul/2006:16:27:42 +0200] cupsdWriteClient: 9 bytes < 0 d [02/Jul/2006:16:27:42 +0200] cupsdWriteClient: Removing fd 9 from OutputSet... d [02/Jul/2006:16:27:42 +0200] cupsdWriteClient: 9 Closing data file 10. d [02/Jul/2006:16:27:42 +0200] cupsdReadClient: 9, used=0, file=-1 state=0 D [02/Jul/2006:16:27:42 +0200] cupsdReadClient: 9 GET /cups.css HTTP/1.1 D [02/Jul/2006:16:27:42 +0200] cupsdReadClient: 9 Browser asked for language "de.utf-8"... d [02/Jul/2006:16:27:42 +0200] cupsdFindBest: uri = "/cups.css"... d [02/Jul/2006:16:27:42 +0200] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0 --Boundary-00=_Z39pEKal4wYc5nb--