Re: [gentoo-user-de] cups: no route to host

[Klaus Jungmann <k.jungmann@ju-ja.de>]

[-- Attachment #1: Type: text/plain, Size: 798 bytes --]

Am Mittwoch, 21. September 2005 09:47 schrieb Sebastian Damm:
> Hallo,
>
> Am 21. September 2005 schrieb Klaus Jungmann:
> > lpadmin -v
> > lpadmin: Unable to connect to server: no route to host
>
> No route to host sagt doch eigentlich, dass der Rechner gar nicht
> erreichbar ist. Hast Du zufällig Deinen Rechner in letzter Zeit mal
> umbenannt und in der /etc/cups/client.conf steht noch der alte Name
> drin?
Dieses Problem hab ich gelöst, hab mich in der cupsd.conf in der Allow Zeile 
vertippt. 
> Ciao
> Sebastian
Der Drucker ist jetzt nach dem HowTo eingerichtet, aber er druckt nicht, und 
gibt keinen Ton von sich. Ich hab den error.log mal angehängt. Vielleicht 
findet ja jemand das problem hier. 

Danke Klaus
-- 
Klaus Jungmann
kjungmann@ju-ja.de
www.ju-ja.de

[-- Attachment #2: cupserror.log --]
[-- Type: text/x-log, Size: 31202 bytes --]

I [22/Sep/2005:10:57:17 +0200] Listening to 0:631
D [22/Sep/2005:10:57:17 +0200] AddLocation: added location '/'
D [22/Sep/2005:10:57:17 +0200] DenyIP: / deny 00000000/00000000
D [22/Sep/2005:10:57:17 +0200] AllowIP: / allow 7f000001/ffffffff
D [22/Sep/2005:10:57:17 +0200] AllowIP: / allow c0a80100/ffffff00
D [22/Sep/2005:10:57:17 +0200] AddLocation: added location '/admin'
D [22/Sep/2005:10:57:17 +0200] DenyIP: /admin deny 00000000/00000000
D [22/Sep/2005:10:57:17 +0200] AllowIP: /admin allow 7f000001/ffffffff
I [22/Sep/2005:10:57:17 +0200] Loaded configuration file "/etc/cups/cupsd.conf"
I [22/Sep/2005:10:57:17 +0200] Configured for up to 100 clients.
I [22/Sep/2005:10:57:17 +0200] Allowing up to 100 client connections per host.
I [22/Sep/2005:10:57:17 +0200] Full reload is required.
D [22/Sep/2005:10:57:17 +0200] LoadAllPrinters: Loading printer BrHL1430...
d [22/Sep/2005:10:57:17 +0200] AddPrinter("BrHL1430")
d [22/Sep/2005:10:57:17 +0200] Adding filter application/vnd.cups-raw printer/BrHL1430 0 -
d [22/Sep/2005:10:57:17 +0200] FindBest: uri = "/printers/BrHL1430"...
d [22/Sep/2005:10:57:17 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:57:17 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:57:17 +0200] FindBest: best = "/"
d [22/Sep/2005:10:57:17 +0200] Adding filter application/vnd.cups-postscript printer/BrHL1430 0 foomatic-rip
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "parallel:/dev/lp0"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "ipp"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "lpd"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS0?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS1?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS2?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS3?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS4?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS5?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS6?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "serial:/dev/ttyS7?baud=115200"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "scsi"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "http"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "socket"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb://Brother/HL-1430%20series"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp1"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp2"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp3"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp4"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp5"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp6"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp7"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp8"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp9"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp10"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp11"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp12"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp13"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp14"...
D [22/Sep/2005:10:57:17 +0200] LoadDevices: Added device "usb:/dev/usb/lp15"...
I [22/Sep/2005:10:57:17 +0200] LoadPPDs: Read "/etc/cups/ppds.dat", 15 PPDs...
I [22/Sep/2005:10:57:17 +0200] LoadPPDs: No new or changed PPDs...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Scanning /var/spool/cups...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 1...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 2...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 3...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 4...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 5...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 6...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 7...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 8...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 9...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 10...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 11...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 12...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 13...
D [22/Sep/2005:10:57:17 +0200] LoadAllJobs: Loading attributes for job 14...
I [22/Sep/2005:10:57:17 +0200] Full reload complete.
D [22/Sep/2005:10:57:17 +0200] StartListening: NumListeners=1
D [22/Sep/2005:10:57:17 +0200] StartListening: address=00000000 port=631
D [22/Sep/2005:10:57:17 +0200] ResumeListening: setting input bits...
d [22/Sep/2005:10:57:17 +0200] ResumeListening: Adding fd 0 to InputSet...
d [22/Sep/2005:10:57:17 +0200] StartBrowsing: Adding fd 2 to InputSet...
d [22/Sep/2005:10:57:17 +0200] StartServer: Adding fd 3 to InputSet...
d [22/Sep/2005:10:57:17 +0200] AddCert: adding certificate for pid 0
d [22/Sep/2005:10:57:18 +0200] select_timeout: 31 seconds to send browse update
d [22/Sep/2005:10:57:26 +0200] AcceptClient(lis=0x808e500) 0 NumClients = 0
D [22/Sep/2005:10:57:26 +0200] AcceptClient: 5 from localhost:631.
d [22/Sep/2005:10:57:26 +0200] AcceptClient: Adding fd 5 to InputSet...
d [22/Sep/2005:10:57:26 +0200] ReadClient: 5, used=0, file=-1
D [22/Sep/2005:10:57:26 +0200] ReadClient: 5 GET /printers/BrHL1430?op=print-test-page HTTP/1.1
d [22/Sep/2005:10:57:26 +0200] decode_auth(0xb7af4008): Authorization string = ""
d [22/Sep/2005:10:57:26 +0200] decode_auth: 5 username=""
d [22/Sep/2005:10:57:26 +0200] IsAuthorized: con->uri = "/printers/BrHL1430?op=print-test-page"
d [22/Sep/2005:10:57:26 +0200] FindBest: uri = "/printers/BrHL1430?op=print-test-page"...
d [22/Sep/2005:10:57:26 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:57:26 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:57:26 +0200] FindBest: best = "/"
d [22/Sep/2005:10:57:26 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:57:26 +0200] pipe_command: command="/usr/lib/cups/cgi-bin/printers.cgi", options="BrHL1430?op=print-test-page"
d [22/Sep/2005:10:57:26 +0200] pipe_command: argv[0] = "BrHL1430"
d [22/Sep/2005:10:57:26 +0200] pipe_command: argv[1] = "op=print-test-page"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[0] = "PATH=/bin:/usr/bin"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[1] = "SERVER_SOFTWARE=CUPS/1.1"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[2] = "GATEWAY_INTERFACE=CGI/1.1"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[3] = "SERVER_PROTOCOL=HTTP/1.1"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[4] = "REDIRECT_STATUS=1"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[5] = "CUPS_SERVER=localhost"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[6] = "IPP_PORT=631"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[7] = "SERVER_NAME=localhost"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[8] = "SERVER_PORT=631"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[9] = "REMOTE_ADDR=127.0.0.1"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[10] = "REMOTE_HOST=localhost"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[11] = "REMOTE_USER="
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[12] = "LANG=de.UTF-8"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[13] = ""
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[14] = "TMPDIR=/var/spool/cups/tmp"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[15] = "CUPS_DATADIR=/usr/share/cups"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[16] = "CUPS_SERVERROOT=/etc/cups"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[17] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; de-DE; rv:1.7.10) Gecko/20050917 Firefox/1.0.6"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[18] = "SCRIPT_NAME=/printers/BrHL1430"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[19] = "REQUEST_METHOD=GET"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[20] = "QUERY_STRING=op=print-test-page"
d [22/Sep/2005:10:57:26 +0200] pipe_command: envp[21] = "CUPS_ENCRYPTION=IfRequested"
d [22/Sep/2005:10:57:26 +0200] AddCert: adding certificate for pid 7351
D [22/Sep/2005:10:57:26 +0200] CGI /usr/lib/cups/cgi-bin/printers.cgi started - PID = 7351
I [22/Sep/2005:10:57:26 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=7351)
D [22/Sep/2005:10:57:26 +0200] SendCommand: 5 file=7
d [22/Sep/2005:10:57:26 +0200] SendCommand: Adding fd 7 to InputSet...
d [22/Sep/2005:10:57:26 +0200] SendCommand: Adding fd 5 to OutputSet...
d [22/Sep/2005:10:57:26 +0200] AcceptClient(lis=0x808e500) 0 NumClients = 1
D [22/Sep/2005:10:57:26 +0200] AcceptClient: 8 from localhost:631.
d [22/Sep/2005:10:57:26 +0200] AcceptClient: Adding fd 8 to InputSet...
d [22/Sep/2005:10:57:26 +0200] WriteClient: 5 Content-Type: text/html;charset=utf-8
d [22/Sep/2005:10:57:26 +0200] WriteClient: 5 
d [22/Sep/2005:10:57:26 +0200] WriteClient: 5 1176 bytes
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8, used=0, file=-1
D [22/Sep/2005:10:57:26 +0200] ReadClient: 8 POST /printers/BrHL1430 HTTP/1.1
d [22/Sep/2005:10:57:26 +0200] decode_auth(0xb7af6c3c): Authorization string = ""
d [22/Sep/2005:10:57:26 +0200] decode_auth: 8 username=""
d [22/Sep/2005:10:57:26 +0200] IsAuthorized: con->uri = "/printers/BrHL1430"
d [22/Sep/2005:10:57:26 +0200] FindBest: uri = "/printers/BrHL1430"...
d [22/Sep/2005:10:57:26 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:57:26 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:57:26 +0200] FindBest: best = "/"
d [22/Sep/2005:10:57:26 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:57:26 +0200] POST /printers/BrHL1430
d [22/Sep/2005:10:57:26 +0200] CONTENT_TYPE = application/ipp
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8 con->data_encoding = length, con->data_remaining = 14753, con->file = -1
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8 REQUEST /var/spool/cups/00000000=9
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8 writing 1730 bytes to 9
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8, used=0, file=9
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8 con->data_encoding = length, con->data_remaining = 12812, con->file = 9
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8 writing 12812 bytes to 9
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8 Closing data file 9, size = 14542.
d [22/Sep/2005:10:57:26 +0200] ProcessIPPRequest(0xb7af6c3c[8]): operation_id = 0002
d [22/Sep/2005:10:57:26 +0200] ProcessIPPRequest: URI="ipp://localhost/printers/BrHL1430"
d [22/Sep/2005:10:57:26 +0200] print_job(0xb7af6c3c[8], ipp://localhost/printers/BrHL1430)
D [22/Sep/2005:10:57:26 +0200] print_job: request file type is application/postscript.
d [22/Sep/2005:10:57:26 +0200] check_quotas(0xb7af6c3c[8], 0x8098e78[BrHL1430])
D [22/Sep/2005:10:57:26 +0200] check_quotas: requesting-user-name = ''
D [22/Sep/2005:10:57:26 +0200] print_job: requesting-user-name = ''
D [22/Sep/2005:10:57:26 +0200] Adding default job-sheets values "none,none"...
I [22/Sep/2005:10:57:26 +0200] Adding start banner page "none" to job 15.
d [22/Sep/2005:10:57:26 +0200] copy_banner(0xb7af6c3c[8], 0x80c3998[15], none)
d [22/Sep/2005:10:57:26 +0200] add_file(con=0xb7af6c3c[8], job=15, filetype=application/postscript, compression=0)
I [22/Sep/2005:10:57:26 +0200] Adding end banner page "none" to job 15.
d [22/Sep/2005:10:57:26 +0200] copy_banner(0xb7af6c3c[8], 0x80c3998[15], none)
I [22/Sep/2005:10:57:26 +0200] Job 15 queued on 'BrHL1430' by ''.
D [22/Sep/2005:10:57:26 +0200] Job 15 hold_until = 0
d [22/Sep/2005:10:57:26 +0200] SaveJob: Closing file 9...
D [22/Sep/2005:10:57:26 +0200] StartJob(15, 0x8098e78)
D [22/Sep/2005:10:57:26 +0200] StartJob() id = 15, file = 0/1
D [22/Sep/2005:10:57:26 +0200] job-sheets=none,none
D [22/Sep/2005:10:57:26 +0200] banner_page = 0
D [22/Sep/2005:10:57:26 +0200] StartJob: argv = "BrHL1430","15","","Test Page","1","","/var/spool/cups/d00015-001"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[2]="USER=root"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[3]="CHARSET=utf-8"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[4]="LANG=de"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[5]="PPD=/etc/cups/ppd/BrHL1430.ppd"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[9]="CONTENT_TYPE=application/postscript"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[10]="DEVICE_URI=usb://Brother/HL-1430%20series"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[11]="PRINTER=BrHL1430"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[14]="CUPS_SERVER=localhost"
D [22/Sep/2005:10:57:26 +0200] StartJob: envp[15]="IPP_PORT=631"
d [22/Sep/2005:10:57:26 +0200] StartJob: Allocating status buffer...
D [22/Sep/2005:10:57:26 +0200] StartJob: statusfds = [ 9 10 ]
D [22/Sep/2005:10:57:26 +0200] StartJob: filterfds[1] = [ 11 -1 ]
D [22/Sep/2005:10:57:26 +0200] StartJob: filter = "/usr/lib/cups/filter/pstops"
D [22/Sep/2005:10:57:26 +0200] StartJob: filterfds[0] = [ 12 13 ]
D [22/Sep/2005:10:57:26 +0200] start_process("/usr/lib/cups/filter/pstops", 0xbfa69360, 0xbfa686d0, 11, 13, 10)
I [22/Sep/2005:10:57:26 +0200] Started filter /usr/lib/cups/filter/pstops (PID 7352) for job 15.
D [22/Sep/2005:10:57:26 +0200] StartJob: filter = "/usr/lib/cups/filter/foomatic-rip"
D [22/Sep/2005:10:57:26 +0200] StartJob: filterfds[1] = [ 11 14 ]
D [22/Sep/2005:10:57:26 +0200] start_process("/usr/lib/cups/filter/foomatic-rip", 0xbfa69360, 0xbfa686d0, 12, 14, 10)
I [22/Sep/2005:10:57:26 +0200] Started filter /usr/lib/cups/filter/foomatic-rip (PID 7353) for job 15.
D [22/Sep/2005:10:57:26 +0200] StartJob: backend = "/usr/lib/cups/backend/usb"
D [22/Sep/2005:10:57:26 +0200] StartJob: filterfds[0] = [ -1 12 ]
D [22/Sep/2005:10:57:26 +0200] start_process("/usr/lib/cups/backend/usb", 0xbfa69360, 0xbfa686d0, 11, 12, 10)
I [22/Sep/2005:10:57:26 +0200] Started backend /usr/lib/cups/backend/usb (PID 7354) for job 15.
d [22/Sep/2005:10:57:26 +0200] StartJob: Adding fd 9 to InputSet...
d [22/Sep/2005:10:57:26 +0200] add_job_state_reasons(0xb7af6c3c[8], 15)
D [22/Sep/2005:10:57:26 +0200] ProcessIPPRequest: 8 status_code=0
d [22/Sep/2005:10:57:26 +0200] ProcessIPPRequest: Adding fd 8 to OutputSet...
E [22/Sep/2005:10:57:26 +0200] PID 7353 stopped with status 22!
D [22/Sep/2005:10:57:26 +0200] [Job 15] Page = 595x842; 0,0 to 595,842
D [22/Sep/2005:10:57:26 +0200] [Job 15] /usr/lib/cups/filter/foomatic-rip: Datei oder Verzeichnis nicht gefunden
d [22/Sep/2005:10:57:26 +0200] WriteClient: Removing fd 8 from OutputSet...
d [22/Sep/2005:10:57:26 +0200] ReadClient: 8, used=0, file=-1
d [22/Sep/2005:10:57:26 +0200] ReadClient: httpGets returned EOF...
D [22/Sep/2005:10:57:26 +0200] CloseClient: 8
d [22/Sep/2005:10:57:26 +0200] CloseClient: Removing fd 8 from InputSet and OutputSet...
D [22/Sep/2005:10:57:26 +0200] [Job 15] slowcollate=0, slowduplex=0, sloworder=0
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%BoundingBox: 0 0 612 792
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%Pages: 1
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%LanguageLevel: 1
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%DocumentData: Clean7Bit
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%DocumentSuppliedResources: procset testprint/1.1
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%Creator: Michael Sweet, Easy Software Products
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%CreationDate: May 11, 1999
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%Title: Test Page
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%EndComments
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%BeginProlog
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%BeginResource procset testprint 1.1 0
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%EndResource
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%EndProlog
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%Page: 1 1
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%Page: 1 1
D [22/Sep/2005:10:57:26 +0200] [Job 15] pw = 595.0, pl = 842.0
D [22/Sep/2005:10:57:26 +0200] [Job 15] PageLeft = 0.0, PageRight = 595.0
D [22/Sep/2005:10:57:26 +0200] [Job 15] PageTop = 842.0, PageBottom = 0.0
D [22/Sep/2005:10:57:26 +0200] [Job 15] PageWidth = 595.0, PageLength = 842.0
D [22/Sep/2005:10:57:26 +0200] [Job 15] 0 %%EOF
D [22/Sep/2005:10:57:26 +0200] [Job 15] Saw EOF!
d [22/Sep/2005:10:57:26 +0200] PID 7351 exited with no errors.
d [22/Sep/2005:10:57:26 +0200] DeleteCert: removing certificate for pid 7351
d [22/Sep/2005:10:57:26 +0200] PID 7352 exited with no errors.
d [22/Sep/2005:10:57:27 +0200] WriteClient: Removing fd 5 from OutputSet...
d [22/Sep/2005:10:57:27 +0200] WriteClient: Removing fd 7 from InputSet...
d [22/Sep/2005:10:57:27 +0200] WriteClient: 5 Closing data file 7.
d [22/Sep/2005:10:57:27 +0200] ReadClient: 5, used=0, file=-1
D [22/Sep/2005:10:57:27 +0200] ReadClient: 5 GET /favicon.ico HTTP/1.1
d [22/Sep/2005:10:57:27 +0200] decode_auth(0xb7af4008): Authorization string = ""
d [22/Sep/2005:10:57:27 +0200] decode_auth: 5 username=""
d [22/Sep/2005:10:57:27 +0200] IsAuthorized: con->uri = "/favicon.ico"
d [22/Sep/2005:10:57:27 +0200] FindBest: uri = "/favicon.ico"...
d [22/Sep/2005:10:57:27 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:57:27 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:57:27 +0200] FindBest: best = "/"
d [22/Sep/2005:10:57:27 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:57:27 +0200] get_file: 5 filename=/usr/share/cups/docs/favicon.ico size=-1
D [22/Sep/2005:10:57:27 +0200] SendError: 5 code=404 (Not Found)
D [22/Sep/2005:10:57:27 +0200] CloseClient: 5
d [22/Sep/2005:10:57:27 +0200] CloseClient: Removing fd 5 from InputSet and OutputSet...
D [22/Sep/2005:10:57:27 +0200] [Job 15] Printer using device file "/dev/usb/lp0"...
D [22/Sep/2005:10:57:27 +0200] [Job 15] LPGETSTATUS returned a port status of 18...
d [22/Sep/2005:10:57:27 +0200] PID 7354 exited with no errors.
D [22/Sep/2005:10:57:27 +0200] UpdateJob: job 15, file 0 is complete.
d [22/Sep/2005:10:57:27 +0200] UpdateJob: Removing fd 9 from InputSet...
D [22/Sep/2005:10:57:27 +0200] CancelJob: id = 15
D [22/Sep/2005:10:57:27 +0200] StopJob: id = 15, force = 0
D [22/Sep/2005:10:57:27 +0200] StopJob: printer state is 3
d [22/Sep/2005:10:57:27 +0200] StopJob: Freeing status buffer...
d [22/Sep/2005:10:57:27 +0200] SaveJob: Closing file 5...
d [22/Sep/2005:10:57:27 +0200] SaveJob: Closing file 5...
d [22/Sep/2005:10:57:28 +0200] select_timeout: 31 seconds to send browse update
d [22/Sep/2005:10:57:59 +0200] select_timeout: 31 seconds to send browse update
d [22/Sep/2005:10:58:02 +0200] AcceptClient(lis=0x808e500) 0 NumClients = 0
D [22/Sep/2005:10:58:02 +0200] AcceptClient: 5 from localhost:631.
d [22/Sep/2005:10:58:02 +0200] AcceptClient: Adding fd 5 to InputSet...
d [22/Sep/2005:10:58:02 +0200] ReadClient: 5, used=0, file=-1
D [22/Sep/2005:10:58:02 +0200] ReadClient: 5 GET /printers/BrHL1430 HTTP/1.1
d [22/Sep/2005:10:58:02 +0200] decode_auth(0xb7af4008): Authorization string = ""
d [22/Sep/2005:10:58:02 +0200] decode_auth: 5 username=""
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: con->uri = "/printers/BrHL1430"
d [22/Sep/2005:10:58:02 +0200] FindBest: uri = "/printers/BrHL1430"...
d [22/Sep/2005:10:58:02 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: best = "/"
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:58:02 +0200] pipe_command: command="/usr/lib/cups/cgi-bin/printers.cgi", options="BrHL1430"
d [22/Sep/2005:10:58:02 +0200] pipe_command: argv[0] = "BrHL1430"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[0] = "PATH=/bin:/usr/bin"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[1] = "SERVER_SOFTWARE=CUPS/1.1"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[2] = "GATEWAY_INTERFACE=CGI/1.1"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[3] = "SERVER_PROTOCOL=HTTP/1.1"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[4] = "REDIRECT_STATUS=1"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[5] = "CUPS_SERVER=localhost"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[6] = "IPP_PORT=631"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[7] = "SERVER_NAME=localhost"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[8] = "SERVER_PORT=631"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[9] = "REMOTE_ADDR=127.0.0.1"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[10] = "REMOTE_HOST=localhost"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[11] = "REMOTE_USER="
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[12] = "LANG=de.UTF-8"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[13] = ""
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[14] = "TMPDIR=/var/spool/cups/tmp"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[15] = "CUPS_DATADIR=/usr/share/cups"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[16] = "CUPS_SERVERROOT=/etc/cups"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[17] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; de-DE; rv:1.7.10) Gecko/20050917 Firefox/1.0.6"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[18] = "SCRIPT_NAME=/printers/BrHL1430"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[19] = "REQUEST_METHOD=GET"
d [22/Sep/2005:10:58:02 +0200] pipe_command: envp[20] = "CUPS_ENCRYPTION=IfRequested"
d [22/Sep/2005:10:58:02 +0200] AddCert: adding certificate for pid 7367
D [22/Sep/2005:10:58:02 +0200] CGI /usr/lib/cups/cgi-bin/printers.cgi started - PID = 7367
I [22/Sep/2005:10:58:02 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=7367)
D [22/Sep/2005:10:58:02 +0200] SendCommand: 5 file=8
d [22/Sep/2005:10:58:02 +0200] SendCommand: Adding fd 8 to InputSet...
d [22/Sep/2005:10:58:02 +0200] SendCommand: Adding fd 5 to OutputSet...
d [22/Sep/2005:10:58:02 +0200] AcceptClient(lis=0x808e500) 0 NumClients = 1
D [22/Sep/2005:10:58:02 +0200] AcceptClient: 7 from localhost:631.
d [22/Sep/2005:10:58:02 +0200] AcceptClient: Adding fd 7 to InputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: 5 Content-Type: text/html;charset=utf-8
d [22/Sep/2005:10:58:02 +0200] WriteClient: 5 
d [22/Sep/2005:10:58:02 +0200] WriteClient: 5 1176 bytes
d [22/Sep/2005:10:58:02 +0200] ReadClient: 7, used=0, file=-1
D [22/Sep/2005:10:58:02 +0200] ReadClient: 7 POST / HTTP/1.1
d [22/Sep/2005:10:58:02 +0200] decode_auth(0xb7af6c3c): Authorization string = ""
d [22/Sep/2005:10:58:02 +0200] decode_auth: 7 username=""
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: con->uri = "/"
d [22/Sep/2005:10:58:02 +0200] FindBest: uri = "/"...
d [22/Sep/2005:10:58:02 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: best = "/"
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:58:02 +0200] POST /
d [22/Sep/2005:10:58:02 +0200] CONTENT_TYPE = application/ipp
d [22/Sep/2005:10:58:02 +0200] ReadClient: 7 con->data_encoding = length, con->data_remaining = 135, con->file = -1
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest(0xb7af6c3c[7]): operation_id = 4001
d [22/Sep/2005:10:58:02 +0200] get_default(0xb7af6c3c[7])
d [22/Sep/2005:10:58:02 +0200] copy_attrs(0x80c4538, 0x80968c0, 0x80c44a8, 0)
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c4538, 0x80968e8[printer-uri-supported,4,45])
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c4538, 0x8096a20[printer-name,4,42])
d [22/Sep/2005:10:58:02 +0200] copy_attrs(0x80c4538, 0x808e270, 0x80c44a8, 0)
D [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: 7 status_code=1
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: Adding fd 7 to OutputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: Removing fd 7 from OutputSet...
d [22/Sep/2005:10:58:02 +0200] ReadClient: 7, used=0, file=-1
D [22/Sep/2005:10:58:02 +0200] ReadClient: 7 POST / HTTP/1.1
d [22/Sep/2005:10:58:02 +0200] decode_auth(0xb7af6c3c): Authorization string = ""
d [22/Sep/2005:10:58:02 +0200] decode_auth: 7 username=""
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: con->uri = "/"
d [22/Sep/2005:10:58:02 +0200] FindBest: uri = "/"...
d [22/Sep/2005:10:58:02 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: best = "/"
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:58:02 +0200] POST /
d [22/Sep/2005:10:58:02 +0200] CONTENT_TYPE = application/ipp
d [22/Sep/2005:10:58:02 +0200] ReadClient: 7 con->data_encoding = length, con->data_remaining = 860, con->file = -1
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest(0xb7af6c3c[7]): operation_id = 000b
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: URI="ipp://localhost/printers/BrHL1430"
d [22/Sep/2005:10:58:02 +0200] get_printer_attrs(0xb7af6c3c[7], ipp://localhost/printers/BrHL1430)
d [22/Sep/2005:10:58:02 +0200] add_printer_state_reasons(0xb7af6c3c[7], 0x8098e78[BrHL1430])
d [22/Sep/2005:10:58:02 +0200] add_queued_job_count(0xb7af6c3c[7], 0x8098e78[BrHL1430])
d [22/Sep/2005:10:58:02 +0200] copy_attrs(0x80c45f8, 0x80968c0, 0x80c4a00, 0)
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c45f8, 0x80968e8[printer-uri-supported,4,45])
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c45f8, 0x8096a20[printer-name,4,42])
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c45f8, 0x8096a70[printer-location,4,41])
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c45f8, 0x8096ac0[printer-info,4,41])
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c45f8, 0x8096ca8[device-uri,4,45])
d [22/Sep/2005:10:58:02 +0200] copy_attribute(0x80c45f8, 0x80a3730[printer-make-and-model,4,41])
d [22/Sep/2005:10:58:02 +0200] copy_attrs(0x80c45f8, 0x808e270, 0x80c4a00, 0)
D [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: 7 status_code=1
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: Adding fd 7 to OutputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: Removing fd 7 from OutputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: 5 1817 bytes
d [22/Sep/2005:10:58:02 +0200] ReadClient: 7, used=0, file=-1
D [22/Sep/2005:10:58:02 +0200] ReadClient: 7 POST / HTTP/1.1
d [22/Sep/2005:10:58:02 +0200] decode_auth(0xb7af6c3c): Authorization string = ""
d [22/Sep/2005:10:58:02 +0200] decode_auth: 7 username=""
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: con->uri = "/"
d [22/Sep/2005:10:58:02 +0200] FindBest: uri = "/"...
d [22/Sep/2005:10:58:02 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: best = "/"
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:58:02 +0200] POST /
d [22/Sep/2005:10:58:02 +0200] CONTENT_TYPE = application/ipp
d [22/Sep/2005:10:58:02 +0200] ReadClient: 7 con->data_encoding = length, con->data_remaining = 422, con->file = -1
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest(0xb7af6c3c[7]): operation_id = 000a
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: URI="ipp://localhost/printers/BrHL1430"
d [22/Sep/2005:10:58:02 +0200] get_jobs(0xb7af6c3c[7], ipp://localhost/printers/BrHL1430)
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 1
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 2
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 3
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 4
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 5
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 6
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 7
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 8
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 9
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 10
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 11
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 12
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 13
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 14
d [22/Sep/2005:10:58:02 +0200] get_jobs: job->id = 15
D [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: 7 status_code=1
d [22/Sep/2005:10:58:02 +0200] ProcessIPPRequest: Adding fd 7 to OutputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: Removing fd 7 from OutputSet...
d [22/Sep/2005:10:58:02 +0200] PID 7367 exited with no errors.
d [22/Sep/2005:10:58:02 +0200] DeleteCert: removing certificate for pid 7367
d [22/Sep/2005:10:58:02 +0200] ReadClient: 7, used=0, file=-1
d [22/Sep/2005:10:58:02 +0200] ReadClient: httpGets returned EOF...
D [22/Sep/2005:10:58:02 +0200] CloseClient: 7
d [22/Sep/2005:10:58:02 +0200] CloseClient: Removing fd 7 from InputSet and OutputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: Removing fd 5 from OutputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: Removing fd 8 from InputSet...
d [22/Sep/2005:10:58:02 +0200] WriteClient: 5 Closing data file 8.
d [22/Sep/2005:10:58:02 +0200] ReadClient: 5, used=0, file=-1
D [22/Sep/2005:10:58:02 +0200] ReadClient: 5 GET /favicon.ico HTTP/1.1
d [22/Sep/2005:10:58:02 +0200] decode_auth(0xb7af4008): Authorization string = ""
d [22/Sep/2005:10:58:02 +0200] decode_auth: 5 username=""
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: con->uri = "/favicon.ico"
d [22/Sep/2005:10:58:02 +0200] FindBest: uri = "/favicon.ico"...
d [22/Sep/2005:10:58:02 +0200] FindBest: Location / Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: Location /admin Limit 7f
d [22/Sep/2005:10:58:02 +0200] FindBest: best = "/"
d [22/Sep/2005:10:58:02 +0200] IsAuthorized: auth = 0, satisfy=0...
d [22/Sep/2005:10:58:02 +0200] get_file: 5 filename=/usr/share/cups/docs/favicon.ico size=-1
D [22/Sep/2005:10:58:02 +0200] SendError: 5 code=404 (Not Found)
D [22/Sep/2005:10:58:02 +0200] CloseClient: 5
d [22/Sep/2005:10:58:02 +0200] CloseClient: Removing fd 5 from InputSet and OutputSet...
d [22/Sep/2005:10:58:03 +0200] select_timeout: 27 seconds to send browse update
d [22/Sep/2005:10:58:30 +0200] select_timeout: 31 seconds to send browse update
d [22/Sep/2005:10:59:01 +0200] select_timeout: 31 seconds to send browse update
d [22/Sep/2005:10:59:32 +0200] select_timeout: 31 seconds to send browse update