client-error-not-possible

Anonymous anonymous at easysw.com
Wed Feb 22 04:40:56 PST 2006


Hello ,
I have problem whith my cusp server . I have instaled server on my localhost , when I want print test page , so status of my jobs is : completed at , but page is not printed .
I have HP 1300 whith print server "Planet" . When I  restarted this jobs  , so I can see error :
client-error-not-possible .
Thanks Otto
Error log :

d [22/Feb/2006:13:37:50 +0100] ReadClient: 9, used=0, file=-1
D [22/Feb/2006:13:37:50 +0100] ReadClient: 9 GET /printers/hp1300?op=print-test-page HTTP/1.1
d [22/Feb/2006:13:37:50 +0100] decode_auth(0xb7aac008): Authorization string = ""
d [22/Feb/2006:13:37:50 +0100] decode_auth: 9 username=""
d [22/Feb/2006:13:37:50 +0100] IsAuthorized: con->uri = "/printers/hp1300?op=print-test-page"
d [22/Feb/2006:13:37:50 +0100] FindBest: uri = "/printers/hp1300?op=print-test-page"...
d [22/Feb/2006:13:37:50 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:50 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:50 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:50 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:50 +0100] pipe_command: command="/usr/lib/cups/cgi-bin/printers.cgi", options="hp1300?op=print-test-page"
d [22/Feb/2006:13:37:50 +0100] pipe_command: argv[0] = "hp1300"
d [22/Feb/2006:13:37:50 +0100] pipe_command: argv[1] = "op=print-test-page"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[0] = "PATH=/bin:/usr/bin"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[1] = "SERVER_SOFTWARE=CUPS/1.1"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[2] = "GATEWAY_INTERFACE=CGI/1.1"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[3] = "SERVER_PROTOCOL=HTTP/1.1"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[4] = "REDIRECT_STATUS=1"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[5] = "CUPS_SERVER=localhost"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[6] = "IPP_PORT=631"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[7] = "SERVER_NAME=localhost"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[8] = "SERVER_PORT=631"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[9] = "REMOTE_ADDR=127.0.0.1"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[10] = "REMOTE_HOST=localhost"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[11] = "REMOTE_USER="
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[12] = "LANG=cs.UTF-8"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[13] = ""
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[14] = "TMPDIR=/var/spool/cups/tmp"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[15] = "CUPS_DATADIR=/usr/share/cups"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[16] = "CUPS_SERVERROOT=/etc/cups"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[17] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.8.0.1) Gecko/20060124 Firefox/1.5.0.1"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[18] = "SCRIPT_NAME=/printers/hp1300"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[19] = "REQUEST_METHOD=GET"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[20] = "QUERY_STRING=op=print-test-page"
d [22/Feb/2006:13:37:50 +0100] pipe_command: envp[21] = "CUPS_ENCRYPTION=IfRequested"
d [22/Feb/2006:13:37:50 +0100] AddCert: adding certificate for pid 21571
D [22/Feb/2006:13:37:50 +0100] CGI /usr/lib/cups/cgi-bin/printers.cgi started - PID = 21571
I [22/Feb/2006:13:37:50 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=21571)
D [22/Feb/2006:13:37:50 +0100] SendCommand: 9 file=7
d [22/Feb/2006:13:37:50 +0100] SendCommand: Adding fd 7 to InputSet...
d [22/Feb/2006:13:37:50 +0100] SendCommand: Adding fd 9 to OutputSet...
d [22/Feb/2006:13:37:50 +0100] AcceptClient(lis=0x809fab0) 0 NumClients = 1
D [22/Feb/2006:13:37:50 +0100] AcceptClient: 5 from localhost:631.
d [22/Feb/2006:13:37:50 +0100] AcceptClient: Adding fd 5 to InputSet...
d [22/Feb/2006:13:37:50 +0100] WriteClient: 9 Content-Type: text/html;charset=utf-8
d [22/Feb/2006:13:37:50 +0100] WriteClient: 9
d [22/Feb/2006:13:37:50 +0100] WriteClient: 9 1169 bytes
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:50 +0100] ReadClient: 5 POST /printers/hp1300 HTTP/1.1
d [22/Feb/2006:13:37:50 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:50 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:50 +0100] IsAuthorized: con->uri = "/printers/hp1300"
d [22/Feb/2006:13:37:50 +0100] FindBest: uri = "/printers/hp1300"...
d [22/Feb/2006:13:37:50 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:50 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:50 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:50 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:50 +0100] POST /printers/hp1300
d [22/Feb/2006:13:37:50 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 14751, con->file = -1
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5 REQUEST /var/spool/cups/00000001=8
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5 writing 1734 bytes to 8
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5, used=0, file=8
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 12808, con->file = 8
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5 writing 12808 bytes to 8
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5 Closing data file 8, size = 14542.
d [22/Feb/2006:13:37:50 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 0002
d [22/Feb/2006:13:37:50 +0100] ProcessIPPRequest: URI="ipp://localhost/printers/hp1300"
d [22/Feb/2006:13:37:50 +0100] print_job(0xb7aaec3c[5], ipp://localhost/printers/hp1300)
D [22/Feb/2006:13:37:50 +0100] print_job: request file type is application/postscript.
d [22/Feb/2006:13:37:50 +0100] check_quotas(0xb7aaec3c[5], 0x80aa588[hp1300])
D [22/Feb/2006:13:37:50 +0100] check_quotas: requesting-user-name = ''
D [22/Feb/2006:13:37:50 +0100] print_job: requesting-user-name = ''
D [22/Feb/2006:13:37:50 +0100] Adding default job-sheets values "none,none"...
I [22/Feb/2006:13:37:50 +0100] Adding start banner page "none" to job 26.
d [22/Feb/2006:13:37:50 +0100] copy_banner(0xb7aaec3c[5], 0x8107120[26], none)
d [22/Feb/2006:13:37:50 +0100] add_file(con=0xb7aaec3c[5], job=26, filetype=application/postscript, compression=0)
I [22/Feb/2006:13:37:50 +0100] Adding end banner page "none" to job 26.
d [22/Feb/2006:13:37:50 +0100] copy_banner(0xb7aaec3c[5], 0x8107120[26], none)
I [22/Feb/2006:13:37:50 +0100] Job 26 queued on 'hp1300' by ''.
D [22/Feb/2006:13:37:50 +0100] Job 26 hold_until = 0
d [22/Feb/2006:13:37:50 +0100] SaveJob: Closing file 8...
D [22/Feb/2006:13:37:50 +0100] StartJob(26, 0x80aa588)
D [22/Feb/2006:13:37:50 +0100] StartJob() id = 26, file = 0/1
D [22/Feb/2006:13:37:50 +0100] job-sheets=none,none
D [22/Feb/2006:13:37:50 +0100] banner_page = 0
D [22/Feb/2006:13:37:50 +0100] StartJob: argv = "hp1300","26","","Test Page","1","","/var/spool/cups/d00026-001"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[2]="USER=root"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[3]="CHARSET=utf-8"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[4]="LANG=cs"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[5]="PPD=/etc/cups/ppd/hp1300.ppd"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[6]="CUPS_SERVERROOT=/etc/cups"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[8]="TMPDIR=/var/spool/cups/tmp"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[9]="CONTENT_TYPE=application/postscript"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[10]="DEVICE_URI=socket://hp1300.cekia.cz:9100"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[11]="PRINTER=hp1300"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[12]="CUPS_DATADIR=/usr/share/cups"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[14]="CUPS_SERVER=localhost"
D [22/Feb/2006:13:37:50 +0100] StartJob: envp[15]="IPP_PORT=631"
d [22/Feb/2006:13:37:50 +0100] StartJob: Allocating status buffer...
D [22/Feb/2006:13:37:50 +0100] StartJob: statusfds = [ 8 10 ]
D [22/Feb/2006:13:37:50 +0100] StartJob: filterfds[1] = [ 12 -1 ]
D [22/Feb/2006:13:37:50 +0100] StartJob: filter = "/usr/lib/cups/filter/pstops"
D [22/Feb/2006:13:37:50 +0100] StartJob: filterfds[0] = [ 13 14 ]
D [22/Feb/2006:13:37:50 +0100] start_process("/usr/lib/cups/filter/pstops", 0xbfd00d80, 0xbfd000f0, 12, 14, 10)
I [22/Feb/2006:13:37:50 +0100] Started filter /usr/lib/cups/filter/pstops (PID 21572) for job 26.
D [22/Feb/2006:13:37:50 +0100] StartJob: backend = "/usr/lib/cups/backend/socket"
D [22/Feb/2006:13:37:50 +0100] StartJob: filterfds[1] = [ -1 12 ]
D [22/Feb/2006:13:37:50 +0100] start_process("/usr/lib/cups/backend/socket", 0xbfd00d80, 0xbfd000f0, 13, 12, 10)
I [22/Feb/2006:13:37:50 +0100] Started backend /usr/lib/cups/backend/socket (PID 21573) for job 26.
d [22/Feb/2006:13:37:50 +0100] StartJob: Adding fd 8 to InputSet...
d [22/Feb/2006:13:37:50 +0100] add_job_state_reasons(0xb7aaec3c[5], 26)
D [22/Feb/2006:13:37:50 +0100] ProcessIPPRequest: 5 status_code=0
d [22/Feb/2006:13:37:50 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:50 +0100] PID 21572 exited with no errors.
D [22/Feb/2006:13:37:50 +0100] [Job 26] Page = 612x792; 12,12 to 600,780
D [22/Feb/2006:13:37:50 +0100] [Job 26] slowcollate=0, slowduplex=0, sloworder=0
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%BoundingBox: 0 0 612 792
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%Pages: 1
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%LanguageLevel: 1
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%DocumentData: Clean7Bit
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%DocumentSuppliedResources: procset testprint/1.1
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%DocumentNeededResources: font Helvetica Helvetica-Bold Times-Roman
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%Creator: Michael Sweet, Easy Software Products
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%CreationDate: May 11, 1999
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%Title: Test Page
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%EndComments
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%BeginProlog
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%BeginResource procset testprint 1.1 0
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%EndResource
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%EndProlog
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%Page: 1 1
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%Page: 1 1
D [22/Feb/2006:13:37:50 +0100] [Job 26] pw = 587.8, pl = 767.8
D [22/Feb/2006:13:37:50 +0100] [Job 26] PageLeft = 12.0, PageRight = 599.8
D [22/Feb/2006:13:37:50 +0100] [Job 26] PageTop = 779.8, PageBottom = 12.0
D [22/Feb/2006:13:37:50 +0100] [Job 26] PageWidth = 612.0, PageLength = 792.0
D [22/Feb/2006:13:37:50 +0100] [Job 26] 0 %%EOF
D [22/Feb/2006:13:37:50 +0100] [Job 26] Saw EOF!
d [22/Feb/2006:13:37:50 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:50 +0100] PID 21571 exited with no errors.
d [22/Feb/2006:13:37:50 +0100] DeleteCert: removing certificate for pid 21571
d [22/Feb/2006:13:37:50 +0100] ReadClient: 5, used=0, file=-1
d [22/Feb/2006:13:37:50 +0100] ReadClient: httpGets returned EOF...
D [22/Feb/2006:13:37:50 +0100] CloseClient: 5
d [22/Feb/2006:13:37:50 +0100] CloseClient: Removing fd 5 from InputSet and OutputSet...
I [22/Feb/2006:13:37:50 +0100] [Job 26] Attempting to connect to host hp1300.cekia.cz on port 9100
I [22/Feb/2006:13:37:50 +0100] [Job 26] Connected to host, sending print job...
d [22/Feb/2006:13:37:50 +0100] WriteClient: Removing fd 9 from OutputSet...
d [22/Feb/2006:13:37:50 +0100] WriteClient: Removing fd 7 from InputSet...
d [22/Feb/2006:13:37:50 +0100] WriteClient: 9 Closing data file 7.
d [22/Feb/2006:13:37:50 +0100] PID 21573 exited with no errors.
I [22/Feb/2006:13:37:50 +0100] [Job 26] Print file sent, waiting for printer to finish...
D [22/Feb/2006:13:37:50 +0100] UpdateJob: job 26, file 0 is complete.
d [22/Feb/2006:13:37:50 +0100] UpdateJob: Removing fd 8 from InputSet...
D [22/Feb/2006:13:37:50 +0100] CancelJob: id = 26
D [22/Feb/2006:13:37:50 +0100] StopJob: id = 26, force = 0
D [22/Feb/2006:13:37:50 +0100] StopJob: printer state is 3
d [22/Feb/2006:13:37:50 +0100] StopJob: Freeing status buffer...
d [22/Feb/2006:13:37:50 +0100] SaveJob: Closing file 5...
d [22/Feb/2006:13:37:50 +0100] SaveJob: Closing file 5...
d [22/Feb/2006:13:37:51 +0100] ReadClient: 9, used=0, file=-1
D [22/Feb/2006:13:37:51 +0100] ReadClient: 9 GET /printers/hp1300 HTTP/1.1
d [22/Feb/2006:13:37:51 +0100] decode_auth(0xb7aac008): Authorization string = ""
d [22/Feb/2006:13:37:51 +0100] decode_auth: 9 username=""
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: con->uri = "/printers/hp1300"
d [22/Feb/2006:13:37:51 +0100] FindBest: uri = "/printers/hp1300"...
d [22/Feb/2006:13:37:51 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:51 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:51 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:51 +0100] pipe_command: command="/usr/lib/cups/cgi-bin/printers.cgi", options="hp1300"
d [22/Feb/2006:13:37:51 +0100] pipe_command: argv[0] = "hp1300"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[0] = "PATH=/bin:/usr/bin"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[1] = "SERVER_SOFTWARE=CUPS/1.1"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[2] = "GATEWAY_INTERFACE=CGI/1.1"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[3] = "SERVER_PROTOCOL=HTTP/1.1"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[4] = "REDIRECT_STATUS=1"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[5] = "CUPS_SERVER=localhost"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[6] = "IPP_PORT=631"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[7] = "SERVER_NAME=localhost"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[8] = "SERVER_PORT=631"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[9] = "REMOTE_ADDR=127.0.0.1"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[10] = "REMOTE_HOST=localhost"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[11] = "REMOTE_USER="
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[12] = "LANG=cs.UTF-8"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[13] = ""
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[14] = "TMPDIR=/var/spool/cups/tmp"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[15] = "CUPS_DATADIR=/usr/share/cups"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[16] = "CUPS_SERVERROOT=/etc/cups"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[17] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.8.0.1) Gecko/20060124 Firefox/1.5.0.1"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[18] = "SCRIPT_NAME=/printers/hp1300"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[19] = "REQUEST_METHOD=GET"
d [22/Feb/2006:13:37:51 +0100] pipe_command: envp[20] = "CUPS_ENCRYPTION=IfRequested"
d [22/Feb/2006:13:37:51 +0100] AddCert: adding certificate for pid 21574
D [22/Feb/2006:13:37:51 +0100] CGI /usr/lib/cups/cgi-bin/printers.cgi started - PID = 21574
I [22/Feb/2006:13:37:51 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=21574)
D [22/Feb/2006:13:37:51 +0100] SendCommand: 9 file=7
d [22/Feb/2006:13:37:51 +0100] SendCommand: Adding fd 7 to InputSet...
d [22/Feb/2006:13:37:51 +0100] SendCommand: Adding fd 9 to OutputSet...
d [22/Feb/2006:13:37:51 +0100] AcceptClient(lis=0x809fab0) 0 NumClients = 1
D [22/Feb/2006:13:37:51 +0100] AcceptClient: 5 from localhost:631.
d [22/Feb/2006:13:37:51 +0100] AcceptClient: Adding fd 5 to InputSet...
d [22/Feb/2006:13:37:51 +0100] WriteClient: 9 Content-Type: text/html;charset=utf-8
d [22/Feb/2006:13:37:51 +0100] WriteClient: 9
d [22/Feb/2006:13:37:51 +0100] WriteClient: 9 1169 bytes
d [22/Feb/2006:13:37:51 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:51 +0100] ReadClient: 5 POST / HTTP/1.1
d [22/Feb/2006:13:37:51 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:51 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: con->uri = "/"
d [22/Feb/2006:13:37:51 +0100] FindBest: uri = "/"...
d [22/Feb/2006:13:37:51 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:51 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:51 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:51 +0100] POST /
d [22/Feb/2006:13:37:51 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:51 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 135, con->file = -1
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 4001
d [22/Feb/2006:13:37:51 +0100] get_default(0xb7aaec3c[5])
d [22/Feb/2006:13:37:51 +0100] copy_attrs(0x8107bf0, 0x80a7ec8, 0x8107b08, 0)
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107bf0, 0x80a7ef0[printer-uri-supported,4,45])
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107bf0, 0x80a8028[printer-name,4,42])
d [22/Feb/2006:13:37:51 +0100] copy_attrs(0x8107bf0, 0x809f878, 0x8107b08, 0)
D [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: 5 status_code=1
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:51 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:51 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:51 +0100] ReadClient: 5 POST / HTTP/1.1
d [22/Feb/2006:13:37:51 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:51 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: con->uri = "/"
d [22/Feb/2006:13:37:51 +0100] FindBest: uri = "/"...
d [22/Feb/2006:13:37:51 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:51 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:51 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:51 +0100] POST /
d [22/Feb/2006:13:37:51 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:51 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 858, con->file = -1
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 000b
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: URI="ipp://localhost/printers/hp1300"
d [22/Feb/2006:13:37:51 +0100] get_printer_attrs(0xb7aaec3c[5], ipp://localhost/printers/hp1300)
d [22/Feb/2006:13:37:51 +0100] add_printer_state_reasons(0xb7aaec3c[5], 0x80aa588[hp1300])
d [22/Feb/2006:13:37:51 +0100] add_queued_job_count(0xb7aaec3c[5], 0x80aa588[hp1300])
d [22/Feb/2006:13:37:51 +0100] copy_attrs(0x8107f58, 0x80a7ec8, 0x8108318, 0)
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107f58, 0x80a7ef0[printer-uri-supported,4,45])
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107f58, 0x80a8028[printer-name,4,42])
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107f58, 0x80a8078[printer-location,4,41])
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107f58, 0x80a80c8[printer-info,4,41])
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107f58, 0x80a82a0[device-uri,4,45])
d [22/Feb/2006:13:37:51 +0100] copy_attribute(0x8107f58, 0x80c1090[printer-make-and-model,4,41])
d [22/Feb/2006:13:37:51 +0100] copy_attrs(0x8107f58, 0x809f878, 0x8108318, 0)
D [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: 5 status_code=1
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:51 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:51 +0100] WriteClient: 9 1878 bytes
d [22/Feb/2006:13:37:51 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:51 +0100] ReadClient: 5 POST / HTTP/1.1
d [22/Feb/2006:13:37:51 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:51 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: con->uri = "/"
d [22/Feb/2006:13:37:51 +0100] FindBest: uri = "/"...
d [22/Feb/2006:13:37:51 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:51 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:51 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:51 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:51 +0100] POST /
d [22/Feb/2006:13:37:51 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:51 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 420, con->file = -1
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 000a
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: URI="ipp://localhost/printers/hp1300"
d [22/Feb/2006:13:37:51 +0100] get_jobs(0xb7aaec3c[5], ipp://localhost/printers/hp1300)
d [22/Feb/2006:13:37:51 +0100] get_jobs: job->id = 21
d [22/Feb/2006:13:37:51 +0100] get_jobs: job->id = 22
d [22/Feb/2006:13:37:51 +0100] get_jobs: job->id = 23
d [22/Feb/2006:13:37:51 +0100] get_jobs: job->id = 24
d [22/Feb/2006:13:37:51 +0100] get_jobs: job->id = 25
d [22/Feb/2006:13:37:51 +0100] get_jobs: job->id = 26
D [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: 5 status_code=1
d [22/Feb/2006:13:37:51 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:51 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:51 +0100] ReadClient: 5, used=0, file=-1
d [22/Feb/2006:13:37:51 +0100] ReadClient: httpGets returned EOF...
D [22/Feb/2006:13:37:51 +0100] CloseClient: 5
d [22/Feb/2006:13:37:51 +0100] CloseClient: Removing fd 5 from InputSet and OutputSet...
d [22/Feb/2006:13:37:51 +0100] PID 21574 exited with no errors.
d [22/Feb/2006:13:37:51 +0100] DeleteCert: removing certificate for pid 21574
d [22/Feb/2006:13:37:51 +0100] WriteClient: Removing fd 9 from OutputSet...
d [22/Feb/2006:13:37:51 +0100] WriteClient: Removing fd 7 from InputSet...
d [22/Feb/2006:13:37:51 +0100] WriteClient: 9 Closing data file 7.
d [22/Feb/2006:13:37:52 +0100] select_timeout: 30 seconds to send browse update
d [22/Feb/2006:13:37:52 +0100] ReadClient: 9, used=0, file=-1
D [22/Feb/2006:13:37:52 +0100] ReadClient: 9 GET /printers/hp1300?which_jobs=completed HTTP/1.1
d [22/Feb/2006:13:37:52 +0100] decode_auth(0xb7aac008): Authorization string = ""
d [22/Feb/2006:13:37:52 +0100] decode_auth: 9 username=""
d [22/Feb/2006:13:37:52 +0100] IsAuthorized: con->uri = "/printers/hp1300?which_jobs=completed"
d [22/Feb/2006:13:37:52 +0100] FindBest: uri = "/printers/hp1300?which_jobs=completed"...
d [22/Feb/2006:13:37:52 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:52 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:52 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:52 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:52 +0100] pipe_command: command="/usr/lib/cups/cgi-bin/printers.cgi", options="hp1300?which_jobs=completed"
d [22/Feb/2006:13:37:52 +0100] pipe_command: argv[0] = "hp1300"
d [22/Feb/2006:13:37:52 +0100] pipe_command: argv[1] = "which_jobs=completed"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[0] = "PATH=/bin:/usr/bin"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[1] = "SERVER_SOFTWARE=CUPS/1.1"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[2] = "GATEWAY_INTERFACE=CGI/1.1"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[3] = "SERVER_PROTOCOL=HTTP/1.1"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[4] = "REDIRECT_STATUS=1"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[5] = "CUPS_SERVER=localhost"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[6] = "IPP_PORT=631"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[7] = "SERVER_NAME=localhost"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[8] = "SERVER_PORT=631"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[9] = "REMOTE_ADDR=127.0.0.1"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[10] = "REMOTE_HOST=localhost"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[11] = "REMOTE_USER="
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[12] = "LANG=cs.UTF-8"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[13] = ""
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[14] = "TMPDIR=/var/spool/cups/tmp"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[15] = "CUPS_DATADIR=/usr/share/cups"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[16] = "CUPS_SERVERROOT=/etc/cups"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[17] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.8.0.1) Gecko/20060124 Firefox/1.5.0.1"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[18] = "SCRIPT_NAME=/printers/hp1300"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[19] = "REQUEST_METHOD=GET"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[20] = "QUERY_STRING=which_jobs=completed"
d [22/Feb/2006:13:37:52 +0100] pipe_command: envp[21] = "CUPS_ENCRYPTION=IfRequested"
d [22/Feb/2006:13:37:52 +0100] AddCert: adding certificate for pid 21575
D [22/Feb/2006:13:37:52 +0100] CGI /usr/lib/cups/cgi-bin/printers.cgi started - PID = 21575
I [22/Feb/2006:13:37:52 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=21575)
D [22/Feb/2006:13:37:52 +0100] SendCommand: 9 file=7
d [22/Feb/2006:13:37:52 +0100] SendCommand: Adding fd 7 to InputSet...
d [22/Feb/2006:13:37:52 +0100] SendCommand: Adding fd 9 to OutputSet...
d [22/Feb/2006:13:37:52 +0100] AcceptClient(lis=0x809fab0) 0 NumClients = 1
D [22/Feb/2006:13:37:52 +0100] AcceptClient: 5 from localhost:631.
d [22/Feb/2006:13:37:52 +0100] AcceptClient: Adding fd 5 to InputSet...
d [22/Feb/2006:13:37:52 +0100] WriteClient: 9 Content-Type: text/html;charset=utf-8
d [22/Feb/2006:13:37:52 +0100] WriteClient: 9
d [22/Feb/2006:13:37:52 +0100] WriteClient: 9 1169 bytes
d [22/Feb/2006:13:37:52 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:52 +0100] ReadClient: 5 POST / HTTP/1.1
d [22/Feb/2006:13:37:52 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:52 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:52 +0100] IsAuthorized: con->uri = "/"
d [22/Feb/2006:13:37:52 +0100] FindBest: uri = "/"...
d [22/Feb/2006:13:37:52 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:52 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:52 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:52 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:52 +0100] POST /
d [22/Feb/2006:13:37:52 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:52 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 135, con->file = -1
d [22/Feb/2006:13:37:52 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 4001
d [22/Feb/2006:13:37:52 +0100] get_default(0xb7aaec3c[5])
d [22/Feb/2006:13:37:52 +0100] copy_attrs(0x81087f8, 0x80a7ec8, 0x81079e8, 0)
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x81087f8, 0x80a7ef0[printer-uri-supported,4,45])
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x81087f8, 0x80a8028[printer-name,4,42])
d [22/Feb/2006:13:37:52 +0100] copy_attrs(0x81087f8, 0x809f878, 0x81079e8, 0)
D [22/Feb/2006:13:37:52 +0100] ProcessIPPRequest: 5 status_code=1
d [22/Feb/2006:13:37:52 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:52 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:52 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:52 +0100] ReadClient: 5 POST / HTTP/1.1
d [22/Feb/2006:13:37:52 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:52 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:52 +0100] IsAuthorized: con->uri = "/"
d [22/Feb/2006:13:37:52 +0100] FindBest: uri = "/"...
d [22/Feb/2006:13:37:52 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:52 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:52 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:52 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:52 +0100] POST /
d [22/Feb/2006:13:37:52 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:52 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 858, con->file = -1
d [22/Feb/2006:13:37:52 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 000b
d [22/Feb/2006:13:37:52 +0100] ProcessIPPRequest: URI="ipp://localhost/printers/hp1300"
d [22/Feb/2006:13:37:52 +0100] get_printer_attrs(0xb7aaec3c[5], ipp://localhost/printers/hp1300)
d [22/Feb/2006:13:37:52 +0100] add_printer_state_reasons(0xb7aaec3c[5], 0x80aa588[hp1300])
d [22/Feb/2006:13:37:52 +0100] add_queued_job_count(0xb7aaec3c[5], 0x80aa588[hp1300])
d [22/Feb/2006:13:37:52 +0100] copy_attrs(0x8108720, 0x80a7ec8, 0x81088a0, 0)
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x8108720, 0x80a7ef0[printer-uri-supported,4,45])
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x8108720, 0x80a8028[printer-name,4,42])
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x8108720, 0x80a8078[printer-location,4,41])
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x8108720, 0x80a80c8[printer-info,4,41])
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x8108720, 0x80a82a0[device-uri,4,45])
d [22/Feb/2006:13:37:52 +0100] copy_attribute(0x8108720, 0x80c1090[printer-make-and-model,4,41])
d [22/Feb/2006:13:37:52 +0100] copy_attrs(0x8108720, 0x809f878, 0x81088a0, 0)
D [22/Feb/2006:13:37:52 +0100] ProcessIPPRequest: 5 status_code=1
d [22/Feb/2006:13:37:52 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:52 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:53 +0100] WriteClient: 9 1878 bytes
d [22/Feb/2006:13:37:53 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:53 +0100] ReadClient: 5 POST / HTTP/1.1
d [22/Feb/2006:13:37:53 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:53 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:53 +0100] IsAuthorized: con->uri = "/"
d [22/Feb/2006:13:37:53 +0100] FindBest: uri = "/"...
d [22/Feb/2006:13:37:53 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:53 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:53 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:53 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:53 +0100] POST /
d [22/Feb/2006:13:37:53 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:53 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 444, con->file = -1
d [22/Feb/2006:13:37:53 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 000a
d [22/Feb/2006:13:37:53 +0100] ProcessIPPRequest: URI="ipp://localhost/printers/hp1300"
d [22/Feb/2006:13:37:53 +0100] get_jobs(0xb7aaec3c[5], ipp://localhost/printers/hp1300)
d [22/Feb/2006:13:37:53 +0100] get_jobs: job->id = 21
d [22/Feb/2006:13:37:53 +0100] get_jobs: count = 1
d [22/Feb/2006:13:37:53 +0100] copy_attrs(0x8107fc8, 0x80f4a98, 0x8108200, 2)
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f4d00[job-originating-user-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f4dc0[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f50a0[job-id,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5140[job-state,2,23])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5290[job-printer-uri,2,45])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5360[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5410[job-k-octets,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f54b8[time-at-creation,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5560[time-at-processing,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5608[time-at-completed,2,21])
d [22/Feb/2006:13:37:53 +0100] add_job_state_reasons(0xb7aaec3c[5], 21)
d [22/Feb/2006:13:37:53 +0100] get_jobs: job->id = 22
d [22/Feb/2006:13:37:53 +0100] get_jobs: count = 2
d [22/Feb/2006:13:37:53 +0100] copy_attrs(0x8107fc8, 0x80f5900, 0x8108200, 2)
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5b68[job-originating-user-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5c28[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5f08[job-id,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f5fa8[job-state,2,23])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f60f8[job-printer-uri,2,45])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f61c8[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f6278[job-k-octets,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f6320[time-at-creation,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f63c8[time-at-processing,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f6470[time-at-completed,2,21])
d [22/Feb/2006:13:37:53 +0100] add_job_state_reasons(0xb7aaec3c[5], 22)
d [22/Feb/2006:13:37:53 +0100] get_jobs: job->id = 23
d [22/Feb/2006:13:37:53 +0100] get_jobs: count = 3
d [22/Feb/2006:13:37:53 +0100] copy_attrs(0x8107fc8, 0x80f6768, 0x8108200, 2)
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f69d0[job-originating-user-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f6a90[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f6d70[job-id,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f6e10[job-state,2,23])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f6f60[job-printer-uri,2,45])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7030[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f70e0[job-k-octets,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7188[time-at-creation,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7230[time-at-processing,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f72d8[time-at-completed,2,21])
d [22/Feb/2006:13:37:53 +0100] add_job_state_reasons(0xb7aaec3c[5], 23)
d [22/Feb/2006:13:37:53 +0100] get_jobs: job->id = 24
d [22/Feb/2006:13:37:53 +0100] get_jobs: count = 4
d [22/Feb/2006:13:37:53 +0100] copy_attrs(0x8107fc8, 0x80f75d0, 0x8108200, 2)
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7838[job-originating-user-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f78f8[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7bd8[job-id,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7c78[job-state,2,23])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7dc8[job-printer-uri,2,45])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7e98[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7f48[job-k-octets,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f7ff0[time-at-creation,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f8098[time-at-processing,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80f8140[time-at-completed,2,21])
d [22/Feb/2006:13:37:53 +0100] add_job_state_reasons(0xb7aaec3c[5], 24)
d [22/Feb/2006:13:37:53 +0100] get_jobs: job->id = 25
d [22/Feb/2006:13:37:53 +0100] get_jobs: count = 5
d [22/Feb/2006:13:37:53 +0100] copy_attrs(0x8107fc8, 0x8104d38, 0x8108200, 2)
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8105088[job-originating-user-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8105508[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x81054d0[job-id,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x80a9c80[job-state,2,23])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8105310[job-printer-uri,2,45])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x81024e0[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8105298[job-k-octets,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8105118[time-at-creation,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8105140[time-at-processing,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8104be0[time-at-completed,2,21])
d [22/Feb/2006:13:37:53 +0100] add_job_state_reasons(0xb7aaec3c[5], 25)
d [22/Feb/2006:13:37:53 +0100] get_jobs: job->id = 26
d [22/Feb/2006:13:37:53 +0100] get_jobs: count = 6
d [22/Feb/2006:13:37:53 +0100] copy_attrs(0x8107fc8, 0x8106e58, 0x8108200, 2)
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8105b28[job-originating-user-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8106f28[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8107250[job-id,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8107288[job-state,2,23])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8107308[job-printer-uri,2,45])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8107370[job-name,2,42])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x81073b8[job-k-octets,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x81073f8[time-at-creation,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8107438[time-at-processing,2,21])
d [22/Feb/2006:13:37:53 +0100] copy_attribute(0x8107fc8, 0x8107478[time-at-completed,2,21])
d [22/Feb/2006:13:37:53 +0100] add_job_state_reasons(0xb7aaec3c[5], 26)
D [22/Feb/2006:13:37:53 +0100] ProcessIPPRequest: 5 status_code=1
d [22/Feb/2006:13:37:53 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:53 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:53 +0100] PID 21575 exited with no errors.
d [22/Feb/2006:13:37:53 +0100] DeleteCert: removing certificate for pid 21575
d [22/Feb/2006:13:37:53 +0100] WriteClient: 9 2048 bytes
d [22/Feb/2006:13:37:53 +0100] ReadClient: 5, used=0, file=-1
d [22/Feb/2006:13:37:53 +0100] ReadClient: httpGets returned EOF...
D [22/Feb/2006:13:37:53 +0100] CloseClient: 5
d [22/Feb/2006:13:37:53 +0100] CloseClient: Removing fd 5 from InputSet and OutputSet...
d [22/Feb/2006:13:37:53 +0100] WriteClient: 9 1186 bytes
d [22/Feb/2006:13:37:53 +0100] WriteClient: Removing fd 9 from OutputSet...
d [22/Feb/2006:13:37:53 +0100] WriteClient: Removing fd 7 from InputSet...
d [22/Feb/2006:13:37:53 +0100] WriteClient: 9 Closing data file 7.
d [22/Feb/2006:13:37:54 +0100] select_timeout: 28 seconds to send browse update
d [22/Feb/2006:13:37:55 +0100] ReadClient: 9, used=0, file=-1
D [22/Feb/2006:13:37:55 +0100] ReadClient: 9 GET /jobs/?op=restart-job&job_id=26&job_printer_uri=/printers/hp1300 HTTP/1.1
d [22/Feb/2006:13:37:55 +0100] decode_auth(0xb7aac008): Authorization string = ""
d [22/Feb/2006:13:37:55 +0100] decode_auth: 9 username=""
d [22/Feb/2006:13:37:55 +0100] IsAuthorized: con->uri = "/jobs/?op=restart-job&job_id=26&job_printer_uri=/printers/hp1300"
d [22/Feb/2006:13:37:55 +0100] FindBest: uri = "/jobs/?op=restart-job&job_id=26&job_printer_uri=/printers/hp1300"...
d [22/Feb/2006:13:37:55 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:55 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:55 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:55 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:55 +0100] pipe_command: command="/usr/lib/cups/cgi-bin/jobs.cgi", options="?op=restart-job&job_id=26&job_printer_uri=/printers/hp1300"
d [22/Feb/2006:13:37:55 +0100] pipe_command: argv[0] = "jobs.cgi"
d [22/Feb/2006:13:37:55 +0100] pipe_command: argv[1] = "op=restart-job&job_id=26&job_printer_uri=/printers/hp1300"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[0] = "PATH=/bin:/usr/bin"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[1] = "SERVER_SOFTWARE=CUPS/1.1"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[2] = "GATEWAY_INTERFACE=CGI/1.1"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[3] = "SERVER_PROTOCOL=HTTP/1.1"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[4] = "REDIRECT_STATUS=1"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[5] = "CUPS_SERVER=localhost"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[6] = "IPP_PORT=631"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[7] = "SERVER_NAME=localhost"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[8] = "SERVER_PORT=631"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[9] = "REMOTE_ADDR=127.0.0.1"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[10] = "REMOTE_HOST=localhost"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[11] = "REMOTE_USER="
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[12] = "LANG=cs.UTF-8"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[13] = ""
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[14] = "TMPDIR=/var/spool/cups/tmp"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[15] = "CUPS_DATADIR=/usr/share/cups"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[16] = "CUPS_SERVERROOT=/etc/cups"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[17] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.8.0.1) Gecko/20060124 Firefox/1.5.0.1"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[18] = "SCRIPT_NAME=/jobs/"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[19] = "REQUEST_METHOD=GET"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[20] = "QUERY_STRING=op=restart-job&job_id=26&job_printer_uri=/printers/hp1300"
d [22/Feb/2006:13:37:55 +0100] pipe_command: envp[21] = "CUPS_ENCRYPTION=IfRequested"
d [22/Feb/2006:13:37:55 +0100] AddCert: adding certificate for pid 21576
D [22/Feb/2006:13:37:55 +0100] CGI /usr/lib/cups/cgi-bin/jobs.cgi started - PID = 21576
I [22/Feb/2006:13:37:55 +0100] Started "/usr/lib/cups/cgi-bin/jobs.cgi" (pid=21576)
D [22/Feb/2006:13:37:55 +0100] SendCommand: 9 file=7
d [22/Feb/2006:13:37:55 +0100] SendCommand: Adding fd 7 to InputSet...
d [22/Feb/2006:13:37:55 +0100] SendCommand: Adding fd 9 to OutputSet...
d [22/Feb/2006:13:37:55 +0100] AcceptClient(lis=0x809fab0) 0 NumClients = 1
D [22/Feb/2006:13:37:55 +0100] AcceptClient: 5 from localhost:631.
d [22/Feb/2006:13:37:55 +0100] AcceptClient: Adding fd 5 to InputSet...
d [22/Feb/2006:13:37:55 +0100] WriteClient: 9 Content-Type: text/html;charset=utf-8
d [22/Feb/2006:13:37:55 +0100] WriteClient: 9
d [22/Feb/2006:13:37:55 +0100] WriteClient: 9 1165 bytes
d [22/Feb/2006:13:37:55 +0100] ReadClient: 5, used=0, file=-1
D [22/Feb/2006:13:37:55 +0100] ReadClient: 5 POST /jobs HTTP/1.1
d [22/Feb/2006:13:37:55 +0100] decode_auth(0xb7aaec3c): Authorization string = ""
d [22/Feb/2006:13:37:55 +0100] decode_auth: 5 username=""
d [22/Feb/2006:13:37:55 +0100] IsAuthorized: con->uri = "/jobs"
d [22/Feb/2006:13:37:55 +0100] FindBest: uri = "/jobs"...
d [22/Feb/2006:13:37:55 +0100] FindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [22/Feb/2006:13:37:55 +0100] FindBest: Location / Limit 7f
d [22/Feb/2006:13:37:55 +0100] FindBest: best = "/"
d [22/Feb/2006:13:37:55 +0100] IsAuthorized: auth = 0, satisfy=0...
d [22/Feb/2006:13:37:55 +0100] POST /jobs
d [22/Feb/2006:13:37:55 +0100] CONTENT_TYPE = application/ipp
d [22/Feb/2006:13:37:55 +0100] ReadClient: 5 con->data_encoding = length, con->data_remaining = 132, con->file = -1
d [22/Feb/2006:13:37:55 +0100] ProcessIPPRequest(0xb7aaec3c[5]): operation_id = 000e
d [22/Feb/2006:13:37:55 +0100] ProcessIPPRequest: URI="ipp://localhost/jobs/26"
d [22/Feb/2006:13:37:55 +0100] restart_job(0xb7aaec3c[5], ipp://localhost/jobs/26)
E [22/Feb/2006:13:37:55 +0100] restart_job: job #26 cannot be restarted - no files!
d [22/Feb/2006:13:37:55 +0100] send_ipp_error(0xb7aaec3c[5], 404)
D [22/Feb/2006:13:37:55 +0100] Sending error: client-error-not-possible
D [22/Feb/2006:13:37:55 +0100] ProcessIPPRequest: 5 status_code=404
d [22/Feb/2006:13:37:55 +0100] ProcessIPPRequest: Adding fd 5 to OutputSet...
d [22/Feb/2006:13:37:55 +0100] WriteClient: Removing fd 5 from OutputSet...
d [22/Feb/2006:13:37:56 +0100] PID 21576 exited with no errors.
d [22/Feb/2006:13:37:56 +0100] DeleteCert: removing certificate for pid 21576
d [22/Feb/2006:13:37:56 +0100] ReadClient: 5, used=0, file=-1
d [22/Feb/2006:13:37:56 +0100] ReadClient: httpGets returned EOF...
D [22/Feb/2006:13:37:56 +0100] CloseClient: 5
d [22/Feb/2006:13:37:56 +0100] CloseClient: Removing fd 5 from InputSet and OutputSet...
d [22/Feb/2006:13:37:56 +0100] WriteClient: Removing fd 9 from OutputSet...
d [22/Feb/2006:13:37:56 +0100] WriteClient: Removing fd 7 from InputSet...
d [22/Feb/2006:13:37:56 +0100] WriteClient: 9 Closing data file 7.
d [22/Feb/2006:13:37:57 +0100] select_timeout: 25 seconds to send browse update
d [22/Feb/2006:13:38:22 +0100] select_timeout: 31 seconds to send browse update





More information about the cups mailing list