Problem printing to cups-lpd
trice2 at gmail.com
trice2 at gmail.com
Thu Jan 12 12:22:45 PST 2012
I'm having issues getting cups-lpd to print anything. The queues are working great for IPP printing, but everything sent to the server as lpd is being aborted with the following errors. Any ideas on how to fix this?
Thanks,
Tim
>From /var/log/syslog:
Jan 12 15:05:30 prntsrv cups-lpd[2021]: Receive print job for ICS_HP1200N
Jan 12 15:05:30 prntsrv cups-lpd[2021]: Print file - job ID = 661681
Jan 12 15:05:30 prntsrv cups-lpd[2021]: Unable to send document - Unauthorized
Jan 12 15:05:30 prntsrv cups-lpd[2021]: Closing connection
>From /var/log/cups/error_log
d [12/Jan/2012:15:05:30 -0500] cupsdAcceptClient(lis=0xb87da408(6)) Clients=0
D [12/Jan/2012:15:05:30 -0500] cupsdAcceptClient: 9 from localhost:631 (IPv4)
d [12/Jan/2012:15:05:30 -0500] cupsdAddSelect(fd=9, read_cb=0xb7799700, write_cb=(nil), data=0xb96478f8)
d [12/Jan/2012:15:05:30 -0500] cupsdDeleteCert: Removing certificate for PID 0
d [12/Jan/2012:15:05:30 -0500] cupsdAddCert: Adding certificate for PID 0
d [12/Jan/2012:15:05:30 -0500] cupsdAddCert: NumSystemGroups=1
d [12/Jan/2012:15:05:30 -0500] cupsdCheckJobs: 0 active jobs, sleeping=0, reload=0
D [12/Jan/2012:15:05:30 -0500] Report: clients=1
D [12/Jan/2012:15:05:30 -0500] Report: jobs=499
D [12/Jan/2012:15:05:30 -0500] Report: jobs-active=0
D [12/Jan/2012:15:05:30 -0500] Report: printers=248
D [12/Jan/2012:15:05:30 -0500] Report: printers-implicit=0
D [12/Jan/2012:15:05:30 -0500] Report: stringpool-string-count=324666
D [12/Jan/2012:15:05:30 -0500] Report: stringpool-alloc-bytes=58608
D [12/Jan/2012:15:05:30 -0500] Report: stringpool-total-bytes=6138808
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=0, con->http.state=0 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=0, con->file=-1
D [12/Jan/2012:15:05:30 -0500] cupsdReadClient: 9 POST / HTTP/1.1
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Active clients
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: uri = "/"...
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location /jobs Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location / Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: best = /
d [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: con->uri="/", con->best=0xb87da2c0(/)
d [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: Authorization=""
D [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: No authentication data provided.
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: con->uri="/", con->best=0xb87da2c0(/)
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: level=CUPSD_AUTH_ANON, type=None, satisfy=CUPSD_AUTH_SATISFY_ALL, num_names=0
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: auth=CUPSD_AUTH_ALLOW...
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=243, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=243, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=214, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=214, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=177, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=177, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=125, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=125, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=88, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=88, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=58, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=58, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=36, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=36, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=19, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=19, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=1, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=1, con->file=-1
D [12/Jan/2012:15:05:30 -0500] cupsdReadClient: 9 1.1 Get-Printer-Attributes 1
d [12/Jan/2012:15:05:30 -0500] cupsdProcessIPPRequest(0xb96478f8[9]): operation_id = 000b
D [12/Jan/2012:15:05:30 -0500] Get-Printer-Attributes ipp://localhost/printers/ICS_HP1200N
d [12/Jan/2012:15:05:30 -0500] get_printer_attrs(0xb96478f8[9], ipp://localhost/printers/ICS_HP1200N)
d [12/Jan/2012:15:05:30 -0500] cupsdFindPolicyOp(p=0xb87d3e58, op=b(Get-Printer-Attributes))
d [12/Jan/2012:15:05:30 -0500] cupsdFindPolicyOp: Found wildcard match...
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: con->uri="/", con->best=0xb87d52d0((null))
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: level=CUPSD_AUTH_ANON, type=None, satisfy=CUPSD_AUTH_SATISFY_ALL, num_names=0
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: con->uri="/", con->best=0xb87d52d0((null))
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: level=CUPSD_AUTH_ANON, type=None, satisfy=CUPSD_AUTH_SATISFY_ALL, num_names=0
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: op=0(unknown-0000)
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: auth=CUPSD_AUTH_ALLOW...
d [12/Jan/2012:15:05:30 -0500] copy_attrs(to=0xb96114d8, from=0xb9223088, ra=0xb964b950, group=0, quickcopy=0)
d [12/Jan/2012:15:05:30 -0500] copy_attribute(0xb96114d8, 0xb9223108[printer-name,4,42])
d [12/Jan/2012:15:05:30 -0500] copy_attribute(0xb96114d8, 0xb92c7010[printer-info,4,41])
d [12/Jan/2012:15:05:30 -0500] copy_attrs(to=0xb96114d8, from=0xb92bc688, ra=0xb964b950, group=0, quickcopy=0)
d [12/Jan/2012:15:05:30 -0500] copy_attrs(to=0xb96114d8, from=0xb87db600, ra=0xb964b950, group=0, quickcopy=-2147483648)
D [12/Jan/2012:15:05:30 -0500] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/ICS_HP1200N) from localhost
d [12/Jan/2012:15:05:30 -0500] cupsdProcessIPPRequest: ippLength(response)=199
d [12/Jan/2012:15:05:30 -0500] cupsdAddSelect(fd=9, read_cb=0xb7799700, write_cb=0xb7796f00, data=0xb96478f8)
d [12/Jan/2012:15:05:30 -0500] select_timeout(0): 301 seconds to timeout a client connection
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(0), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdAddSelect(fd=9, read_cb=0xb7799700, write_cb=(nil), data=0xb96478f8)
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Not busy
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=0, con->http.state=0 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=0, con->file=-1
D [12/Jan/2012:15:05:30 -0500] cupsdReadClient: 9 POST /printers/ICS_HP1200N HTTP/1.1
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: con->uri="/", con->best=0xb87d52d0((null))
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: level=CUPSD_AUTH_ANON, type=None, satisfy=CUPSD_AUTH_SATISFY_ALL, num_names=0
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: op=0(unknown-0000)
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: auth=CUPSD_AUTH_ALLOW...
d [12/Jan/2012:15:05:30 -0500] copy_attrs(to=0xb96114d8, from=0xb9223088, ra=0xb964b950, group=0, quickcopy=0)
d [12/Jan/2012:15:05:30 -0500] copy_attribute(0xb96114d8, 0xb9223108[printer-name,4,42])
d [12/Jan/2012:15:05:30 -0500] copy_attribute(0xb96114d8, 0xb92c7010[printer-info,4,41])
d [12/Jan/2012:15:05:30 -0500] copy_attrs(to=0xb96114d8, from=0xb92bc688, ra=0xb964b950, group=0, quickcopy=0)
d [12/Jan/2012:15:05:30 -0500] copy_attrs(to=0xb96114d8, from=0xb87db600, ra=0xb964b950, group=0, quickcopy=-2147483648)
D [12/Jan/2012:15:05:30 -0500] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/ICS_HP1200N) from localhost
d [12/Jan/2012:15:05:30 -0500] cupsdProcessIPPRequest: ippLength(response)=199
d [12/Jan/2012:15:05:30 -0500] cupsdAddSelect(fd=9, read_cb=0xb7799700, write_cb=0xb7796f00, data=0xb96478f8)
d [12/Jan/2012:15:05:30 -0500] select_timeout(0): 301 seconds to timeout a client connection
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(0), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb96114d8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdAddSelect(fd=9, read_cb=0xb7799700, write_cb=(nil), data=0xb96478f8)
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Not busy
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=0, con->http.state=0 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=0, con->file=-1
D [12/Jan/2012:15:05:30 -0500] cupsdReadClient: 9 POST /printers/ICS_HP1200N HTTP/1.1
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Active clients
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: uri = "/printers/ICS_HP1200N"...
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location /jobs Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location /admin Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location / Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: best = /
d [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: con->uri="/printers/ICS_HP1200N", con->best=0xb87da2c0(/)
d [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: Authorization=""
D [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: No authentication data provided.
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: con->uri="/printers/ICS_HP1200N", con->best=0xb87da2c0(/)
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: level=CUPSD_AUTH_ANON, type=None, satisfy=CUPSD_AUTH_SATISFY_ALL, num_names=0
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: auth=CUPSD_AUTH_ALLOW...
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=297, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=297, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=268, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=268, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=231, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=231, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=179, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=179, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=147, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=147, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=125, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=125, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=98, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=98, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=54, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=54, con->file=-1
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=1, con->http.state=6 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=1, con->file=-1
D [12/Jan/2012:15:05:30 -0500] cupsdReadClient: 9 1.1 Create-Job 1
d [12/Jan/2012:15:05:30 -0500] cupsdProcessIPPRequest(0xb96478f8[9]): operation_id = 0005
D [12/Jan/2012:15:05:30 -0500] Create-Job ipp://localhost/printers/ICS_HP1200N
d [12/Jan/2012:15:05:30 -0500] create_job(0xb96478f8[9], ipp://localhost/printers/ICS_HP1200N)
d [12/Jan/2012:15:05:30 -0500] add_job(0xb96478f8[9], 0xb92bbd38(ICS_HP1200N), (nil)(none/none))
d [12/Jan/2012:15:05:30 -0500] cupsdFindPolicyOp(p=0xb87d3e58, op=5(Create-Job))
d [12/Jan/2012:15:05:30 -0500] cupsdFindPolicyOp: Found wildcard match...
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: con->uri="/printers/ICS_HP1200N", con->best=0xb87d52d0((null))
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: level=CUPSD_AUTH_ANON, type=None, satisfy=CUPSD_AUTH_SATISFY_ALL, num_names=0
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: op=0(unknown-0000)
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: auth=CUPSD_AUTH_ALLOW...
d [12/Jan/2012:15:05:30 -0500] check_quotas(0xb96478f8[9], 0xb92bbd38[ICS_HP1200N])
D [12/Jan/2012:15:05:30 -0500] cupsdMarkDirty(----J-)
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Active clients and dirty files
D [12/Jan/2012:15:05:30 -0500] add_job: requesting-user-name="trice"
D [12/Jan/2012:15:05:30 -0500] Adding default job-sheets values "none,none"...
I [12/Jan/2012:15:05:30 -0500] [Job 661681] Adding start banner page "none".
d [12/Jan/2012:15:05:30 -0500] copy_banner(con=0xb96478f8[9], job=0xb964bd40[661681], name="none")
d [12/Jan/2012:15:05:30 -0500] add_job_state_reasons(0xb96478f8[9], 661681)
d [12/Jan/2012:15:05:30 -0500] cupsdAddEvent(event=job-created, dest=0xb92bbd38(ICS_HP1200N), job=0xb964bd40(661681), text="Job created.", ...)
D [12/Jan/2012:15:05:30 -0500] Discarding unused job-created event...
I [12/Jan/2012:15:05:30 -0500] [Job 661681] Queued on "ICS_HP1200N" by "trice".
D [12/Jan/2012:15:05:30 -0500] Returning IPP successful-ok for Create-Job (ipp://localhost/printers/ICS_HP1200N) from localhost
d [12/Jan/2012:15:05:30 -0500] cupsdProcessIPPRequest: ippLength(response)=211
d [12/Jan/2012:15:05:30 -0500] cupsdAddSelect(fd=9, read_cb=0xb7799700, write_cb=0xb7796f00, data=0xb96478f8)
d [12/Jan/2012:15:05:30 -0500] select_timeout(0): 31 seconds to write dirty config/state files
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb964c6b8(0), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb964c6b8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb964c6b8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb964c6b8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb964c6b8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb964c6b8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdWriteClient(con=0xb96478f8(9)) response=0xb964c6b8(2), file=-1 pipe_pid=0 state=7
d [12/Jan/2012:15:05:30 -0500] cupsdAddSelect(fd=9, read_cb=0xb7799700, write_cb=(nil), data=0xb96478f8)
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Dirty files
d [12/Jan/2012:15:05:30 -0500] cupsdReadClient(con=0xb96478f8(9)) con->http.error=0 con->http.used=0, con->http.state=0 con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=0, con->file=-1
D [12/Jan/2012:15:05:30 -0500] cupsdReadClient: 9 POST /jobs/661681 HTTP/1.1
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Active clients and dirty files
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: uri = "/jobs/661681"...
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL Limit 0
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location /jobs Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location /admin Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: Location / Limit 7f
d [12/Jan/2012:15:05:30 -0500] cupsdFindBest: best = /jobs
d [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: con->uri="/jobs/661681", con->best=0xb87da728(/jobs)
d [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: Authorization=""
D [12/Jan/2012:15:05:30 -0500] cupsdAuthorize: No authentication data provided.
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: con->uri="/jobs/661681", con->best=0xb87da728(/jobs)
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: level=CUPSD_AUTH_USER, type=Basic, satisfy=CUPSD_AUTH_SATISFY_ALL, num_names=0
d [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: auth=CUPSD_AUTH_ALLOW...
D [12/Jan/2012:15:05:30 -0500] cupsdIsAuthorized: username=""
d [12/Jan/2012:15:05:30 -0500] cupsdSendError(con=0xb96478f8(9), code=401, auth_type=0
D [12/Jan/2012:15:05:30 -0500] cupsdSendHeader: 9 WWW-Authenticate: Basic realm="CUPS"
D [12/Jan/2012:15:05:30 -0500] cupsdCloseClient: 9
D [12/Jan/2012:15:05:30 -0500] cupsdSetBusyState: Dirty files
d [12/Jan/2012:15:05:30 -0500] cupsdRemoveSelect(fd=9)
d [12/Jan/2012:15:05:31 -0500] select_timeout(0): 30 seconds to write dirty config/state files
I [12/Jan/2012:15:06:01 -0500] Saving job cache file "/var/cache/cups/job.cache"...
d [12/Jan/2012:15:06:01 -0500] cupsdSaveJob(job=0xb964bd40(661681)): job->attrs=0xb96114d8
D [12/Jan/2012:15:06:01 -0500] cupsdSetBusyState: Not busy
d [12/Jan/2012:15:06:01 -0500] cupsdCheckJobs: 1 active jobs, sleeping=0, reload=0
d [12/Jan/2012:15:06:01 -0500] select_timeout(0): 270 seconds to release held jobs
More information about the cups
mailing list