Attachment 870956 Details for Bug 1072952 – cups error log

cups error log

error_log (text/plain), 65.91 KB, created by Jens Kleineheismann on 2014-03-05 13:19:06 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Jens Kleineheismann

Created: 2014-03-05 13:19:06 UTC

Size: 65.91 KB

patch

obsolete

>I [05/Mar/2014:13:39:00 +0100] Listening to [v1.::1]:631 (IPv6)
>I [05/Mar/2014:13:39:00 +0100] Listening to 127.0.0.1:631 (IPv4)
>I [05/Mar/2014:13:39:00 +0100] Listening to /var/run/cups/cups.sock (Domain)
>I [05/Mar/2014:13:39:00 +0100] Remote access is disabled.
>D [05/Mar/2014:13:39:00 +0100] Added auto ServerAlias em-rock.iism.kit.edu
>D [05/Mar/2014:13:39:00 +0100] Added auto ServerAlias em-rock
>I [05/Mar/2014:13:39:00 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
>I [05/Mar/2014:13:39:00 +0100] Using default TempDir of /var/spool/cups/tmp...
>I [05/Mar/2014:13:39:00 +0100] Configured for up to 100 clients.
>I [05/Mar/2014:13:39:00 +0100] Allowing up to 100 client connections per host.
>I [05/Mar/2014:13:39:00 +0100] Using policy "default" as the default.
>I [05/Mar/2014:13:39:00 +0100] Full reload is required.
>I [05/Mar/2014:13:39:00 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 39 types, 52 filters...
>D [05/Mar/2014:13:39:00 +0100] Loading printer rp01...
>D [05/Mar/2014:13:39:00 +0100] load_ppd: Loading /var/cache/cups/rp01.data...
>D [05/Mar/2014:13:39:00 +0100] cupsdRegisterPrinter(p=0x7fe40c2e6ab0(rp01))
>I [05/Mar/2014:13:39:00 +0100] Loading job cache file "/var/cache/cups/job.cache"...
>I [05/Mar/2014:13:39:00 +0100] Full reload complete.
>D [05/Mar/2014:13:39:00 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
>I [05/Mar/2014:13:39:00 +0100] Cleaning out old files in "/var/spool/cups/tmp".
>D [05/Mar/2014:13:39:00 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
>I [05/Mar/2014:13:39:00 +0100] Cleaning out old files in "/var/cache/cups".
>D [05/Mar/2014:13:39:00 +0100] systemd_checkin: Matched existing listener /var/run/cups/cups.sock with fd 3...
>D [05/Mar/2014:13:39:00 +0100] Calling FindDeviceById(cups-rp01)
>D [05/Mar/2014:13:39:00 +0100] FindDeviceById failed: org.freedesktop.ColorManager.NotFound:device id 'cups-rp01' does not exist
>D [05/Mar/2014:13:39:00 +0100] Using profile ID "rp01-Gray..".
>D [05/Mar/2014:13:39:00 +0100] Calling CreateProfile(rp01-Gray..,temp)
>D [05/Mar/2014:13:39:00 +0100] Created profile "/org/freedesktop/ColorManager/profiles/rp01_Gray__".
>I [05/Mar/2014:13:39:00 +0100] Registering ICC color profiles for "rp01".
>D [05/Mar/2014:13:39:00 +0100] Calling CreateDevice(cups-rp01,temp)
>D [05/Mar/2014:13:39:00 +0100] Created device "/org/freedesktop/ColorManager/devices/cups_rp01".
>D [05/Mar/2014:13:39:00 +0100] Calling /org/freedesktop/ColorManager/devices/cups_rp01:AddProfile(/org/freedesktop/ColorManager/profiles/rp01_Gray__) [soft]
>I [05/Mar/2014:13:39:00 +0100] Listening to [v1.::1]:631 on fd 12...
>I [05/Mar/2014:13:39:00 +0100] Listening to 127.0.0.1:631 on fd 13...
>I [05/Mar/2014:13:39:00 +0100] Listening to /var/run/cups/cups.sock:631 on fd 3...
>I [05/Mar/2014:13:39:00 +0100] Resuming new connection processing...
>D [05/Mar/2014:13:39:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:39:00 +0100] Discarding unused server-started event...
>D [05/Mar/2014:13:39:01 +0100] Report: clients=0
>D [05/Mar/2014:13:39:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:39:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:39:01 +0100] Report: printers=1
>D [05/Mar/2014:13:39:01 +0100] Report: stringpool-string-count=11989
>D [05/Mar/2014:13:39:01 +0100] Report: stringpool-alloc-bytes=9824
>D [05/Mar/2014:13:39:01 +0100] Report: stringpool-total-bytes=220056
>D [05/Mar/2014:13:39:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:39:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:39:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:39:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:39:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:39:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:39:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:39:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:39:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:39:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:39:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:39:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:39:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:39:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:39:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:39:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:39:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:39:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:39:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:39:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:40:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:40:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:40:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:40:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:40:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:40:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:40:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:40:00 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:40:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:40:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:40:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Content-Length: 1184
>D [05/Mar/2014:13:40:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:40:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:40:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:40:00 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:40:00 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Content-Length: 113
>D [05/Mar/2014:13:40:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecb90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:40:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:40:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:40:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:40:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:40:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:00 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:40:00 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:40:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:40:01 +0100] Report: clients=0
>D [05/Mar/2014:13:40:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:40:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:40:01 +0100] Report: printers=1
>D [05/Mar/2014:13:40:01 +0100] Report: stringpool-string-count=11994
>D [05/Mar/2014:13:40:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:40:01 +0100] Report: stringpool-total-bytes=220136
>D [05/Mar/2014:13:40:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:40:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:40:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:40:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:40:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:40:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Content-Length: 1184
>D [05/Mar/2014:13:40:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c423020(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:40:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:40:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:40:30 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:40:30 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Content-Length: 113
>D [05/Mar/2014:13:40:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecb90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:40:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:40:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:40:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Content-Length: 451
>D [05/Mar/2014:13:40:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c423020(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:40:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:40:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:40:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:40:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:41:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:41:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:41:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:41:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:41:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:41:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:41:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:41:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:41:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:41:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:41:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:41:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:41:00 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:41:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:41:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:41:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Content-Length: 1184
>D [05/Mar/2014:13:41:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:41:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:41:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:41:00 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:41:00 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Content-Length: 113
>D [05/Mar/2014:13:41:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecb90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:41:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:41:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:41:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:41:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:41:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:41:00 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:41:00 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:41:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:41:01 +0100] Report: clients=0
>D [05/Mar/2014:13:41:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:41:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:41:01 +0100] Report: printers=1
>D [05/Mar/2014:13:41:01 +0100] Report: stringpool-string-count=12000
>D [05/Mar/2014:13:41:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:41:01 +0100] Report: stringpool-total-bytes=220232
>D [05/Mar/2014:13:41:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:41:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:41:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:41:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:41:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:41:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:41:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:41:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:41:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:41:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:41:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:41:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:41:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:41:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:41:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:41:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:41:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:41:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:41:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:41:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:42:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:42:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:42:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:42:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:42:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:42:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:42:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:42:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:42:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:42:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:42:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:42:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:42:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:42:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:42:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:42:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:42:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:42:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:42:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:42:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:42:01 +0100] Report: clients=0
>D [05/Mar/2014:13:42:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:42:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:42:01 +0100] Report: printers=1
>D [05/Mar/2014:13:42:01 +0100] Report: stringpool-string-count=12004
>D [05/Mar/2014:13:42:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:42:01 +0100] Report: stringpool-total-bytes=220296
>D [05/Mar/2014:13:42:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:42:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:42:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:42:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:42:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:42:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:42:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:42:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:42:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:42:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:42:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:42:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:42:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:42:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:42:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:42:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Content-Length: 1184
>D [05/Mar/2014:13:42:30 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:42:30 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:42:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:42:30 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:42:30 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Content-Length: 113
>D [05/Mar/2014:13:42:30 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecb90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:42:30 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:42:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:42:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:42:30 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:42:30 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:42:30 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:42:30 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:42:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:43:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:43:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:43:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:43:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:43:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:43:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:43:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:43:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:43:00 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:43:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:43:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:43:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Content-Length: 1184
>D [05/Mar/2014:13:43:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:43:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:43:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:43:00 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:43:00 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Content-Length: 113
>D [05/Mar/2014:13:43:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecb90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:43:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:43:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:43:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:43:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:43:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:00 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:43:00 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:43:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:43:01 +0100] Report: clients=0
>D [05/Mar/2014:13:43:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:43:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:43:01 +0100] Report: printers=1
>D [05/Mar/2014:13:43:01 +0100] Report: stringpool-string-count=12010
>D [05/Mar/2014:13:43:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:43:01 +0100] Report: stringpool-total-bytes=220392
>D [05/Mar/2014:13:43:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:43:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:43:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:43:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:43:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:43:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Content-Length: 1184
>D [05/Mar/2014:13:43:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c3eda90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:43:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:43:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:43:30 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:43:30 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Content-Length: 113
>D [05/Mar/2014:13:43:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecb90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:43:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:43:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:43:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Content-Length: 451
>D [05/Mar/2014:13:43:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c3eda90(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:43:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:43:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:43:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:43:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:44:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:44:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:44:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:44:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:44:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:44:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:44:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:44:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:44:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:44:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:44:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:44:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:44:00 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:44:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:44:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:44:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Content-Length: 1184
>D [05/Mar/2014:13:44:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:44:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:44:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:44:00 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:44:00 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Content-Length: 113
>D [05/Mar/2014:13:44:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecf40(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:44:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:44:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:44:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:44:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:44:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:44:00 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:44:00 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:44:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:44:01 +0100] Report: clients=0
>D [05/Mar/2014:13:44:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:44:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:44:01 +0100] Report: printers=1
>D [05/Mar/2014:13:44:01 +0100] Report: stringpool-string-count=12016
>D [05/Mar/2014:13:44:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:44:01 +0100] Report: stringpool-total-bytes=220488
>D [05/Mar/2014:13:44:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:44:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:44:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:44:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:44:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:44:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:44:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:44:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:44:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:44:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:44:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:44:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:44:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:44:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:44:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:44:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:44:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:44:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:44:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:44:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:45:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:45:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:45:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:45:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:45:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:45:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:45:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:45:00 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:45:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:45:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:45:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Content-Length: 1184
>D [05/Mar/2014:13:45:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:45:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:45:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:45:00 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:45:00 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Content-Length: 113
>D [05/Mar/2014:13:45:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecf40(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:45:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:45:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:45:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:45:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c411540(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:45:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:00 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:45:00 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:45:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:45:01 +0100] Report: clients=0
>D [05/Mar/2014:13:45:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:45:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:45:01 +0100] Report: printers=1
>D [05/Mar/2014:13:45:01 +0100] Report: stringpool-string-count=12021
>D [05/Mar/2014:13:45:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:45:01 +0100] Report: stringpool-total-bytes=220568
>D [05/Mar/2014:13:45:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:45:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:45:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:45:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:45:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] 1.1 CUPS-Get-Printers 1
>D [05/Mar/2014:13:45:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Content-Length: 1184
>D [05/Mar/2014:13:45:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=1184, response=0x7fe40c423020(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:45:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:45:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] 1.1 CUPS-Get-Default 2
>D [05/Mar/2014:13:45:30 +0100] CUPS-Get-Default
>D [05/Mar/2014:13:45:30 +0100] CUPS-Get-Default client-error-not-found: No default printer.
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Content-Length: 113
>D [05/Mar/2014:13:45:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0x7fe40c3ecf40(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:45:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Authorized as root using PeerCred
>D [05/Mar/2014:13:45:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] 1.1 CUPS-Get-Printers 3
>D [05/Mar/2014:13:45:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Content-Length: 451
>D [05/Mar/2014:13:45:30 +0100] [Client 16] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c423020(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:45:30 +0100] [Client 16] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:45:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:45:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:45:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:46:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:46:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:46:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:46:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:46:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:46:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:46:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:46:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:46:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:46:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:46:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:46:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:46:00 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:46:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:46:00 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:46:00 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:46:00 +0100] [Client 17] 1.1 CUPS-Get-Printers 2
>D [05/Mar/2014:13:46:00 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:46:00 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c4112e0(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:46:00 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:46:00 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:46:00 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:46:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:46:01 +0100] Report: clients=0
>D [05/Mar/2014:13:46:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:46:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:46:01 +0100] Report: printers=1
>D [05/Mar/2014:13:46:01 +0100] Report: stringpool-string-count=12028
>D [05/Mar/2014:13:46:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:46:01 +0100] Report: stringpool-total-bytes=220680
>D [05/Mar/2014:13:46:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:46:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:46:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:46:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:46:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:46:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:46:30 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:46:30 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:46:30 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:46:30 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:46:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:46:30 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Accepted from localhost (Domain)
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:46:30 +0100] [Client 16] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:46:30 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:46:30 +0100] [Client 17] POST / HTTP/1.1
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Authorized as root using PeerCred
>D [05/Mar/2014:13:46:30 +0100] cupsdIsAuthorized: username="root"
>D [05/Mar/2014:13:46:30 +0100] [Client 17] 1.1 CUPS-Get-Printers 2
>D [05/Mar/2014:13:46:30 +0100] CUPS-Get-Printers
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Content-Length: 451
>D [05/Mar/2014:13:46:30 +0100] [Client 17] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=451, response=0x7fe40c4112e0(IPP_IDLE), pipe_pid=0, file=-1
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
>D [05/Mar/2014:13:46:30 +0100] [Client 17] bytes=0, http_state=0, data_remaining=0
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Waiting for request.
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:46:30 +0100] [Client 17] HTTP_STATE_WAITING Closing on EOF
>D [05/Mar/2014:13:46:30 +0100] [Client 17] Closing connection.
>D [05/Mar/2014:13:46:30 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [05/Mar/2014:13:47:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:47:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:47:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:47:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:47:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:47:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:47:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:47:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:47:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:47:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:47:00 +0100] cupsdAcceptClient: skipping getpeercon()
>D [05/Mar/2014:13:47:00 +0100] [Client 16] Accepted from localhost (Domain)
>D [05/Mar/2014:13:47:00 +0100] [Client 16] Waiting for request.
>D [05/Mar/2014:13:47:00 +0100] [Client 16] POST / HTTP/1.1
>D [05/Mar/2014:13:47:00 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [05/Mar/2014:13:47:00 +0100] [Client 16] No authentication data provided.
>D [05/Mar/2014:13:47:00 +0100] cupsdIsAuthorized: username=""
>D [05/Mar/2014:13:47:00 +0100] [Client 16] WWW-Authenticate: Basic realm="CUPS"
>D [05/Mar/2014:13:47:00 +0100] [Client 16] Closing connection.
>D [05/Mar/2014:13:47:00 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
>D [05/Mar/2014:13:47:01 +0100] Report: clients=0
>D [05/Mar/2014:13:47:01 +0100] Report: jobs=0
>D [05/Mar/2014:13:47:01 +0100] Report: jobs-active=0
>D [05/Mar/2014:13:47:01 +0100] Report: printers=1
>D [05/Mar/2014:13:47:01 +0100] Report: stringpool-string-count=12034
>D [05/Mar/2014:13:47:01 +0100] Report: stringpool-alloc-bytes=9848
>D [05/Mar/2014:13:47:01 +0100] Report: stringpool-total-bytes=220776

Actions: View

Attachments on bug 1072952: 870955 | 870956 | 870957 | 870958 | 870959 | 870960 | 870978 | 871944 | 871946 | 871948 | 886893