W [14/Mar/2012:13:50:39 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'DCP-7020-Gray..' already exists
W [14/Mar/2012:13:50:39 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-DCP-7020' already exists
W [14/Mar/2012:13:50:39 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'MFC-8680DN-Gray..' already exists
W [14/Mar/2012:13:50:39 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-MFC-8680DN' already exists
E [14/Mar/2012:14:55:21 -0500] [Job 16] Unable to send data to printer.
E [14/Mar/2012:14:56:46 -0500] [Job 16] Unable to send data to printer.
E [14/Mar/2012:14:58:18 -0500] [Job 16] Unable to send data to printer.
I [14/Mar/2012:16:27:02 -0500] Remote access is disabled.
D [14/Mar/2012:16:27:02 -0500] Added auto ServerAlias amati
I [14/Mar/2012:16:27:02 -0500] Loaded configuration file "/etc/cups/cupsd.conf"
I [14/Mar/2012:16:27:02 -0500] Using default TempDir of /var/spool/cups/tmp...
I [14/Mar/2012:16:27:02 -0500] Configured for up to 100 clients.
I [14/Mar/2012:16:27:02 -0500] Allowing up to 100 client connections per host.
I [14/Mar/2012:16:27:02 -0500] Using policy "default" as the default.
D [14/Mar/2012:16:27:02 -0500] load_ppd: Loading /var/cache/cups/DCP-7020.data...
D [14/Mar/2012:16:27:02 -0500] Calling DeleteDevice(cups-DCP-7020)
D [14/Mar/2012:16:27:02 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:27:02 -0500] Using profile id of DCP-7020-Gray..
D [14/Mar/2012:16:27:02 -0500] Calling CreateProfile(DCP-7020-Gray..,temp)
W [14/Mar/2012:16:27:02 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'DCP-7020-Gray..' already exists
I [14/Mar/2012:16:27:02 -0500] Registering ICC color profiles for "DCP-7020"
D [14/Mar/2012:16:27:02 -0500] Calling CreateDevice(cups-DCP-7020,temp)
W [14/Mar/2012:16:27:02 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-DCP-7020' already exists
D [14/Mar/2012:16:27:02 -0500] cupsdRegisterPrinter(p=0x7fd1b0e5ca80(DCP-7020))
D [14/Mar/2012:16:27:02 -0500] load_ppd: Loading /var/cache/cups/MFC-8680DN.data...
D [14/Mar/2012:16:27:02 -0500] Calling DeleteDevice(cups-MFC-8680DN)
D [14/Mar/2012:16:27:02 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:27:02 -0500] Using profile id of MFC-8680DN-Gray..
D [14/Mar/2012:16:27:02 -0500] Calling CreateProfile(MFC-8680DN-Gray..,temp)
W [14/Mar/2012:16:27:02 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'MFC-8680DN-Gray..' already exists
I [14/Mar/2012:16:27:02 -0500] Registering ICC color profiles for "MFC-8680DN"
D [14/Mar/2012:16:27:02 -0500] Calling CreateDevice(cups-MFC-8680DN,temp)
W [14/Mar/2012:16:27:02 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-MFC-8680DN' already exists
D [14/Mar/2012:16:27:02 -0500] cupsdRegisterPrinter(p=0x7fd1b0ec08a0(MFC-8680DN))
D [14/Mar/2012:16:27:02 -0500] cupsdMarkDirty(---p--)
D [14/Mar/2012:16:27:02 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
I [14/Mar/2012:16:27:02 -0500] Partial reload complete.
I [14/Mar/2012:16:27:02 -0500] Listening to [v1.::1]:631 on fd 9...
I [14/Mar/2012:16:27:02 -0500] Listening to 127.0.0.1:631 on fd 10...
I [14/Mar/2012:16:27:02 -0500] Listening to /var/run/cups/cups.sock:631 on fd 11...
I [14/Mar/2012:16:27:02 -0500] Resuming new connection processing...
D [14/Mar/2012:16:27:02 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:27:02 -0500] Discarding unused server-restarted event...
D [14/Mar/2012:16:27:03 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:27:03 -0500] Report: clients=1
D [14/Mar/2012:16:27:03 -0500] Report: jobs=14
D [14/Mar/2012:16:27:03 -0500] Report: jobs-active=0
D [14/Mar/2012:16:27:03 -0500] Report: printers=2
D [14/Mar/2012:16:27:03 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:27:03 -0500] Report: stringpool-string-count=6698
D [14/Mar/2012:16:27:03 -0500] Report: stringpool-alloc-bytes=11928
D [14/Mar/2012:16:27:03 -0500] Report: stringpool-total-bytes=123504
I [14/Mar/2012:16:27:33 -0500] Generating printcap /var/run/cups/printcap...
D [14/Mar/2012:16:27:33 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [14/Mar/2012:16:27:37 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:27:37 -0500] cupsdReadClient: 16 GET /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:27:37 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:27:37 -0500] cupsdIsAuthorized: username=""
D [14/Mar/2012:16:27:37 -0500] cupsdSendHeader: 16 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [14/Mar/2012:16:27:37 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:27:37 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:27:37 -0500] cupsdReadClient: 16 GET /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:27:37 -0500] cupsdAuthorize: Authorized as bruce using PeerCred
D [14/Mar/2012:16:27:37 -0500] cupsdIsAuthorized: username="bruce"
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:27:37 -0500] cupsdReadClient: 16 GET /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:27:37 -0500] cupsdAuthorize: Authorized as bruce using PeerCred
D [14/Mar/2012:16:27:37 -0500] cupsdIsAuthorized: username="bruce"
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:27:37 -0500] cupsdReadClient: 16 PUT /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:27:37 -0500] cupsdAuthorize: Authorized as bruce using PeerCred
D [14/Mar/2012:16:27:37 -0500] cupsdIsAuthorized: username="bruce"
I [14/Mar/2012:16:27:37 -0500] Installing config file "/etc/cups/cupsd.conf"...
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:27:37 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:27:37 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
I [14/Mar/2012:16:27:37 -0500] Remote access is disabled.
D [14/Mar/2012:16:27:37 -0500] Added auto ServerAlias amati
I [14/Mar/2012:16:27:37 -0500] Loaded configuration file "/etc/cups/cupsd.conf"
I [14/Mar/2012:16:27:37 -0500] Using default TempDir of /var/spool/cups/tmp...
I [14/Mar/2012:16:27:37 -0500] Configured for up to 100 clients.
I [14/Mar/2012:16:27:37 -0500] Allowing up to 100 client connections per host.
I [14/Mar/2012:16:27:37 -0500] Using policy "default" as the default.
D [14/Mar/2012:16:27:37 -0500] load_ppd: Loading /var/cache/cups/DCP-7020.data...
D [14/Mar/2012:16:27:37 -0500] Calling DeleteDevice(cups-DCP-7020)
D [14/Mar/2012:16:27:37 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:27:37 -0500] Using profile id of DCP-7020-Gray..
D [14/Mar/2012:16:27:37 -0500] Calling CreateProfile(DCP-7020-Gray..,temp)
W [14/Mar/2012:16:27:37 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'DCP-7020-Gray..' already exists
I [14/Mar/2012:16:27:37 -0500] Registering ICC color profiles for "DCP-7020"
D [14/Mar/2012:16:27:37 -0500] Calling CreateDevice(cups-DCP-7020,temp)
W [14/Mar/2012:16:27:37 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-DCP-7020' already exists
D [14/Mar/2012:16:27:37 -0500] cupsdRegisterPrinter(p=0x7fd1b0e5ca80(DCP-7020))
D [14/Mar/2012:16:27:37 -0500] load_ppd: Loading /var/cache/cups/MFC-8680DN.data...
D [14/Mar/2012:16:27:37 -0500] Calling DeleteDevice(cups-MFC-8680DN)
D [14/Mar/2012:16:27:37 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:27:37 -0500] Using profile id of MFC-8680DN-Gray..
D [14/Mar/2012:16:27:37 -0500] Calling CreateProfile(MFC-8680DN-Gray..,temp)
W [14/Mar/2012:16:27:37 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'MFC-8680DN-Gray..' already exists
I [14/Mar/2012:16:27:37 -0500] Registering ICC color profiles for "MFC-8680DN"
D [14/Mar/2012:16:27:37 -0500] Calling CreateDevice(cups-MFC-8680DN,temp)
W [14/Mar/2012:16:27:37 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-MFC-8680DN' already exists
D [14/Mar/2012:16:27:37 -0500] cupsdRegisterPrinter(p=0x7fd1b0ec08a0(MFC-8680DN))
D [14/Mar/2012:16:27:37 -0500] cupsdMarkDirty(---p--)
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
I [14/Mar/2012:16:27:37 -0500] Partial reload complete.
I [14/Mar/2012:16:27:37 -0500] Listening to [v1.::1]:631 on fd 9...
I [14/Mar/2012:16:27:37 -0500] Listening to 127.0.0.1:631 on fd 10...
I [14/Mar/2012:16:27:37 -0500] Listening to /var/run/cups/cups.sock:631 on fd 11...
I [14/Mar/2012:16:27:37 -0500] Resuming new connection processing...
D [14/Mar/2012:16:27:37 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:27:37 -0500] Discarding unused server-restarted event...
D [14/Mar/2012:16:27:38 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:27:38 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:27:38 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:27:38 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:27:38 -0500] cupsdReadClient: 14 1.1 Get-Notifications 1
D [14/Mar/2012:16:27:38 -0500] Get-Notifications /
D [14/Mar/2012:16:27:38 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:27:38 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:27:38 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:27:38 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:27:38 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:27:38 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [14/Mar/2012:16:28:08 -0500] Generating printcap /var/run/cups/printcap...
D [14/Mar/2012:16:28:08 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [14/Mar/2012:16:28:08 -0500] Report: clients=0
D [14/Mar/2012:16:28:08 -0500] Report: jobs=14
D [14/Mar/2012:16:28:08 -0500] Report: jobs-active=0
D [14/Mar/2012:16:28:08 -0500] Report: printers=2
D [14/Mar/2012:16:28:08 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:28:08 -0500] Report: stringpool-string-count=6898
D [14/Mar/2012:16:28:08 -0500] Report: stringpool-alloc-bytes=13448
D [14/Mar/2012:16:28:08 -0500] Report: stringpool-total-bytes=125808
D [14/Mar/2012:16:28:24 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:28:24 -0500] cupsdReadClient: 14 GET /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:28:24 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:28:24 -0500] cupsdIsAuthorized: username=""
D [14/Mar/2012:16:28:24 -0500] cupsdSendHeader: 14 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [14/Mar/2012:16:28:24 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:28:24 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:28:24 -0500] cupsdReadClient: 14 GET /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:28:24 -0500] cupsdAuthorize: Authorized as bruce using PeerCred
D [14/Mar/2012:16:28:24 -0500] cupsdIsAuthorized: username="bruce"
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:28:24 -0500] cupsdReadClient: 14 GET /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:28:24 -0500] cupsdAuthorize: Authorized as bruce using PeerCred
D [14/Mar/2012:16:28:24 -0500] cupsdIsAuthorized: username="bruce"
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:28:24 -0500] cupsdReadClient: 14 PUT /admin/conf/cupsd.conf HTTP/1.1
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:28:24 -0500] cupsdAuthorize: Authorized as bruce using PeerCred
D [14/Mar/2012:16:28:24 -0500] cupsdIsAuthorized: username="bruce"
I [14/Mar/2012:16:28:24 -0500] Installing config file "/etc/cups/cupsd.conf"...
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:28:24 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
I [14/Mar/2012:16:28:24 -0500] Remote access is disabled.
D [14/Mar/2012:16:28:24 -0500] Added auto ServerAlias amati
I [14/Mar/2012:16:28:24 -0500] Loaded configuration file "/etc/cups/cupsd.conf"
I [14/Mar/2012:16:28:24 -0500] Using default TempDir of /var/spool/cups/tmp...
I [14/Mar/2012:16:28:24 -0500] Configured for up to 100 clients.
I [14/Mar/2012:16:28:24 -0500] Allowing up to 100 client connections per host.
I [14/Mar/2012:16:28:24 -0500] Using policy "default" as the default.
D [14/Mar/2012:16:28:24 -0500] load_ppd: Loading /var/cache/cups/DCP-7020.data...
D [14/Mar/2012:16:28:24 -0500] Calling DeleteDevice(cups-DCP-7020)
D [14/Mar/2012:16:28:24 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:28:24 -0500] Using profile id of DCP-7020-Gray..
D [14/Mar/2012:16:28:24 -0500] Calling CreateProfile(DCP-7020-Gray..,temp)
W [14/Mar/2012:16:28:24 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'DCP-7020-Gray..' already exists
I [14/Mar/2012:16:28:24 -0500] Registering ICC color profiles for "DCP-7020"
D [14/Mar/2012:16:28:24 -0500] Calling CreateDevice(cups-DCP-7020,temp)
W [14/Mar/2012:16:28:24 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-DCP-7020' already exists
D [14/Mar/2012:16:28:24 -0500] cupsdRegisterPrinter(p=0x7fd1b0e5ca80(DCP-7020))
D [14/Mar/2012:16:28:24 -0500] load_ppd: Loading /var/cache/cups/MFC-8680DN.data...
D [14/Mar/2012:16:28:24 -0500] Calling DeleteDevice(cups-MFC-8680DN)
D [14/Mar/2012:16:28:24 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:28:24 -0500] Using profile id of MFC-8680DN-Gray..
D [14/Mar/2012:16:28:24 -0500] Calling CreateProfile(MFC-8680DN-Gray..,temp)
W [14/Mar/2012:16:28:24 -0500] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'MFC-8680DN-Gray..' already exists
I [14/Mar/2012:16:28:24 -0500] Registering ICC color profiles for "MFC-8680DN"
D [14/Mar/2012:16:28:24 -0500] Calling CreateDevice(cups-MFC-8680DN,temp)
W [14/Mar/2012:16:28:24 -0500] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-MFC-8680DN' already exists
D [14/Mar/2012:16:28:24 -0500] cupsdRegisterPrinter(p=0x7fd1b0ec08a0(MFC-8680DN))
D [14/Mar/2012:16:28:24 -0500] cupsdMarkDirty(---p--)
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
I [14/Mar/2012:16:28:24 -0500] Partial reload complete.
I [14/Mar/2012:16:28:24 -0500] Listening to [v1.::1]:631 on fd 9...
I [14/Mar/2012:16:28:24 -0500] Listening to 127.0.0.1:631 on fd 10...
I [14/Mar/2012:16:28:24 -0500] Listening to /var/run/cups/cups.sock:631 on fd 11...
I [14/Mar/2012:16:28:24 -0500] Resuming new connection processing...
D [14/Mar/2012:16:28:24 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:28:24 -0500] Discarding unused server-restarted event...
D [14/Mar/2012:16:28:38 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:28:38 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:28:38 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:28:38 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:28:38 -0500] cupsdReadClient: 14 1.1 Get-Notifications 1
D [14/Mar/2012:16:28:38 -0500] Get-Notifications /
D [14/Mar/2012:16:28:38 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:28:38 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:28:38 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:28:38 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:28:38 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:28:38 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [14/Mar/2012:16:28:55 -0500] Generating printcap /var/run/cups/printcap...
D [14/Mar/2012:16:28:55 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [14/Mar/2012:16:29:38 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:38 -0500] Report: clients=1
D [14/Mar/2012:16:29:38 -0500] Report: jobs=14
D [14/Mar/2012:16:29:38 -0500] Report: jobs-active=0
D [14/Mar/2012:16:29:38 -0500] Report: printers=2
D [14/Mar/2012:16:29:38 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:29:38 -0500] Report: stringpool-string-count=7101
D [14/Mar/2012:16:29:38 -0500] Report: stringpool-alloc-bytes=15120
D [14/Mar/2012:16:29:38 -0500] Report: stringpool-total-bytes=128360
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 14 1.1 Get-Notifications 1
D [14/Mar/2012:16:29:38 -0500] Get-Notifications /
D [14/Mar/2012:16:29:38 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:29:38 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:38 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:38 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:38 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:38 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:38 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:38 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:38 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 14 GET /printers/MFC-8680DN.ppd HTTP/1.1
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:38 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:38 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:38 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:38 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:38 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:38 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:38 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:38 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:38 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:39 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:39 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:39 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:39 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:39 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:39 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:39 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:39 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:39 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:39 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:40 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:40 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:40 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:40 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:40 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:40 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:40 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:40 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:41 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:41 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:41 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:41 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:41 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:41 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:41 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:41 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:41 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:41 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:41 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:41 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:41 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:42 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:42 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:42 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:42 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:42 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:42 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:42 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:42 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:42 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:42 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:42 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:42 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:42 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:42 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:43 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:43 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:43 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:43 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:43 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:43 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:43 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:43 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:43 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:43 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:43 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:43 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:43 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:43 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:44 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST /printers/MFC-8680DN HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 Print-Job 1
D [14/Mar/2012:16:29:44 -0500] Print-Job ipp://localhost:631/printers/MFC-8680DN
D [14/Mar/2012:16:29:44 -0500] [Job ???] Auto-typing file...
I [14/Mar/2012:16:29:44 -0500] [Job ???] Request file type is application/pdf.
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(----J-)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [14/Mar/2012:16:29:44 -0500] add_job: requesting-user-name="bruce"
I [14/Mar/2012:16:29:44 -0500] [Job 28] Adding start banner page "none".
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(----J-)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [14/Mar/2012:16:29:44 -0500] [Job 28] Adding end banner page "none".
I [14/Mar/2012:16:29:44 -0500] [Job 28] File of type application/pdf queued by "bruce".
D [14/Mar/2012:16:29:44 -0500] [Job 28] hold_until=0
I [14/Mar/2012:16:29:44 -0500] [Job 28] Queued on "MFC-8680DN" by "bruce".
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(----J-)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:44 -0500] [Job 28] job-sheets=none,none
D [14/Mar/2012:16:29:44 -0500] [Job 28] argv[0]="MFC-8680DN"
D [14/Mar/2012:16:29:44 -0500] [Job 28] argv[1]="28"
D [14/Mar/2012:16:29:44 -0500] [Job 28] argv[2]="bruce"
D [14/Mar/2012:16:29:44 -0500] [Job 28] argv[3]="dvar.list.txt"
D [14/Mar/2012:16:29:44 -0500] [Job 28] argv[4]="1"
D [14/Mar/2012:16:29:44 -0500] [Job 28] argv[5]="BRDensityAdjustment=None number-up=1 PageSize=Letter Duplex=None noManualFeed InputSlot=AutoSelect noTonerSaveMode BRJobHold=None BRMediaType=Plain ScreenLock noBRReducedImage ImprovePrintOutput=None BRJobPIN=HoldKey0 BRJobName=JobNameSystem CAPT=Middle job-uuid=urn:uuid:1e053b12-0d29-3146-55de-4221e4a088e0 job-originating-host-name=localhost time-at-creation=1331760584 time-at-processing=1331760584"
D [14/Mar/2012:16:29:44 -0500] [Job 28] argv[6]="/var/spool/cups/d00028-001"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[8]="HOME=/var/spool/cups/tmp"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[10]="SERVER_ADMIN=root@amati"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[11]="SOFTWARE=CUPS/1.5.2"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[13]="USER=root"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[16]="IPP_PORT=631"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[17]="CHARSET=utf-8"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[18]="LANG=en_US.UTF-8"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[19]="PPD=/etc/cups/ppd/MFC-8680DN.ppd"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[20]="RIP_MAX_CACHE=128m"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[21]="CONTENT_TYPE=application/pdf"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[22]="DEVICE_URI=usb://Brother/MFC-8680DN?serial=000M0J605091"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[23]="PRINTER_INFO=Brother MFC-8680DN"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[24]="PRINTER_LOCATION=amati"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[25]="PRINTER=MFC-8680DN"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[26]="PRINTER_STATE_REASONS=none"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[27]="CUPS_FILETYPE=document"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
D [14/Mar/2012:16:29:44 -0500] [Job 28] envp[29]="AUTH_I****"
I [14/Mar/2012:16:29:44 -0500] [Job 28] Started filter /usr/lib/cups/filter/pdftopdf (PID 2063)
I [14/Mar/2012:16:29:44 -0500] [Job 28] Started filter /usr/lib/cups/filter/pdftops (PID 2064)
I [14/Mar/2012:16:29:44 -0500] [Job 28] Started backend /usr/lib/cups/backend/usb (PID 2065)
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/MFC-8680DN) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] [Job 28] print_device
D [14/Mar/2012:16:29:44 -0500] [Job 28] pdftops - copying to temp print file "/tmp/008104f690ba8"
D [14/Mar/2012:16:29:44 -0500] [Job 28] libusb_get_device_list=14
D [14/Mar/2012:16:29:44 -0500] PID 2063 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [14/Mar/2012:16:29:44 -0500] [Job 28] Started filter gs (PID 2066)
D [14/Mar/2012:16:29:44 -0500] [Job 28] Started post-processing (PID 2067)
D [14/Mar/2012:16:29:44 -0500] [Job 28] Started filter pstops (PID 2068)
D [14/Mar/2012:16:29:44 -0500] [Job 28] **** Warning: File has some garbage before %PDF- .
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 Get-Notifications 1
D [14/Mar/2012:16:29:44 -0500] Get-Notifications /
D [14/Mar/2012:16:29:44 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 17 1.1 Get-Notifications 1
D [14/Mar/2012:16:29:44 -0500] Get-Notifications /
D [14/Mar/2012:16:29:44 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 17 1.1 Get-Job-Attributes 1
D [14/Mar/2012:16:29:44 -0500] Get-Job-Attributes ipp://localhost/jobs/28
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/28) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 Get-Printer-Attributes 1
D [14/Mar/2012:16:29:44 -0500] Get-Printer-Attributes 
D [14/Mar/2012:16:29:44 -0500] Get-Printer-Attributes client-error-not-found: The printer or class does not exist.
D [14/Mar/2012:16:29:44 -0500] Returning IPP client-error-not-found for Get-Printer-Attributes () from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 18 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 18 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 18 1.1 Get-Job-Attributes 1
D [14/Mar/2012:16:29:44 -0500] Get-Job-Attributes ipp://localhost/jobs/28
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/28) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 18 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 18
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 Get-Job-Attributes 1
D [14/Mar/2012:16:29:44 -0500] Get-Job-Attributes ipp://localhost/jobs/28
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/28) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 Get-Job-Attributes 1
D [14/Mar/2012:16:29:44 -0500] Get-Job-Attributes ipp://localhost/jobs/28
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/28) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [14/Mar/2012:16:29:44 -0500] cupsdCloseClient: 17
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] [Job 28] STATE: +connecting-to-device
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] [Job 28] STATE: -connecting-to-device
D [14/Mar/2012:16:29:44 -0500] [Job 28] STATE: +connecting-to-device
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:44 -0500] [Job 28] STATE: -connecting-to-device
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
I [14/Mar/2012:16:29:44 -0500] [Job 28] Sending data to printer.
D [14/Mar/2012:16:29:44 -0500] [Job 28] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:44 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Classes 1
D [14/Mar/2012:16:29:44 -0500] CUPS-Get-Classes
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:44 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:44 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [14/Mar/2012:16:29:44 -0500] CUPS-Get-Default
D [14/Mar/2012:16:29:44 -0500] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [14/Mar/2012:16:29:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 1.1 Get-Notifications 1
D [14/Mar/2012:16:29:45 -0500] Get-Notifications /
D [14/Mar/2012:16:29:45 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 18 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 18 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 18 1.1 Get-Notifications 1
D [14/Mar/2012:16:29:45 -0500] Get-Notifications /
D [14/Mar/2012:16:29:45 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 19 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 19 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 19 1.1 Get-Job-Attributes 1
D [14/Mar/2012:16:29:45 -0500] Get-Job-Attributes ipp://localhost/jobs/28
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/28) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 19 WAITING Closing on EOF
D [14/Mar/2012:16:29:45 -0500] cupsdCloseClient: 19
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 19 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 18 WAITING Closing on EOF
D [14/Mar/2012:16:29:45 -0500] cupsdCloseClient: 18
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [14/Mar/2012:16:29:45 -0500] cupsdCloseClient: 17
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] [Job 28] Inserted workaround PostScript code for Brother printers
D [14/Mar/2012:16:29:45 -0500] [Job 28] Page = 612x792; 12,12 to 600,780
D [14/Mar/2012:16:29:45 -0500] [Job 28] slow_collate=0, slow_duplex=0, slow_order=0
D [14/Mar/2012:16:29:45 -0500] [Job 28] Before copy_comments - %!PS-Adobe-3.0
D [14/Mar/2012:16:29:45 -0500] [Job 28] %!PS-Adobe-3.0
D [14/Mar/2012:16:29:45 -0500] [Job 28] %%BoundingBox: 0 0 612 792
D [14/Mar/2012:16:29:45 -0500] [Job 28] %%Creator: GPL Ghostscript 905 (ps2write)
D [14/Mar/2012:16:29:45 -0500] [Job 28] %%LanguageLevel: 2
D [14/Mar/2012:16:29:45 -0500] [Job 28] %%CreationDate: D:20120314162944-05'00'
D [14/Mar/2012:16:29:45 -0500] [Job 28] %%Pages: 2
D [14/Mar/2012:16:29:45 -0500] [Job 28] %%EndComments
D [14/Mar/2012:16:29:45 -0500] [Job 28] Before copy_prolog - %%BeginProlog
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 4096 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 4096 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 4096 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 4096 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] PID 2066 (gs) exited with no errors.
D [14/Mar/2012:16:29:45 -0500] [Job 28] PID 2067 (Post-processing) exited with no errors.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:45 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Classes 1
D [14/Mar/2012:16:29:45 -0500] CUPS-Get-Classes
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [14/Mar/2012:16:29:45 -0500] CUPS-Get-Default
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Before copy_setup - %%Page: 1 1
D [14/Mar/2012:16:29:45 -0500] [Job 28] Before page loop - %%Page: 1 1
D [14/Mar/2012:16:29:45 -0500] [Job 28] Copying page 1...
D [14/Mar/2012:16:29:45 -0500] [Job 28] PAGE: 1 1
D [14/Mar/2012:16:29:45 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] [Job 28] pagew = 587.9, pagel = 767.9
D [14/Mar/2012:16:29:45 -0500] [Job 28] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [14/Mar/2012:16:29:45 -0500] [Job 28] PageLeft = 12.0, PageRight = 599.9
D [14/Mar/2012:16:29:45 -0500] [Job 28] PageTop = 780.0, PageBottom = 12.1
D [14/Mar/2012:16:29:45 -0500] [Job 28] PageWidth = 612.0, PageLength = 792.0
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Copying page 2...
D [14/Mar/2012:16:29:45 -0500] [Job 28] PAGE: 2 1
D [14/Mar/2012:16:29:45 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] [Job 28] pagew = 587.9, pagel = 767.9
D [14/Mar/2012:16:29:45 -0500] [Job 28] bboxx = 0, bboxy = 0, bboxw = 612, bboxl = 792
D [14/Mar/2012:16:29:45 -0500] [Job 28] PageLeft = 12.0, PageRight = 599.9
D [14/Mar/2012:16:29:45 -0500] [Job 28] PageTop = 780.0, PageBottom = 12.1
D [14/Mar/2012:16:29:45 -0500] [Job 28] PageWidth = 612.0, PageLength = 792.0
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 2 pages...
D [14/Mar/2012:16:29:45 -0500] [Job 28] PID 2068 (pstops) exited with no errors.
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] PID 2064 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 8192 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Read 6131 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Wrote 6131 bytes of print data...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Sent 137203 bytes...
D [14/Mar/2012:16:29:45 -0500] [Job 28] Waiting for read thread to exit...
D [14/Mar/2012:16:29:45 -0500] PID 2065 (/usr/lib/cups/backend/usb) exited with no errors.
D [14/Mar/2012:16:29:45 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
I [14/Mar/2012:16:29:45 -0500] [Job 28] Job completed.
D [14/Mar/2012:16:29:45 -0500] cupsdMarkDirty(----J-)
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 16 1.1 Get-Notifications 1
D [14/Mar/2012:16:29:45 -0500] Get-Notifications /
D [14/Mar/2012:16:29:45 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 1.1 Get-Notifications 1
D [14/Mar/2012:16:29:45 -0500] Get-Notifications /
D [14/Mar/2012:16:29:45 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [14/Mar/2012:16:29:45 -0500] cupsdCloseClient: 17
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 1.1 Get-Job-Attributes 1
D [14/Mar/2012:16:29:45 -0500] Get-Job-Attributes ipp://localhost/jobs/28
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/28) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [14/Mar/2012:16:29:45 -0500] cupsdCloseClient: 17
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 1.1 Get-Job-Attributes 1
D [14/Mar/2012:16:29:45 -0500] Get-Job-Attributes ipp://localhost/jobs/28
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/28) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [14/Mar/2012:16:29:45 -0500] cupsdCloseClient: 17
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAcceptClient: 17 from localhost (Domain)
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 17 1.1 Get-Printer-Attributes 1
D [14/Mar/2012:16:29:45 -0500] Get-Printer-Attributes ipp://amati/printers/MFC-8680DN
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for Get-Printer-Attributes (ipp://amati/printers/MFC-8680DN) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:29:45 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:29:45 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Classes 1
D [14/Mar/2012:16:29:45 -0500] CUPS-Get-Classes
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:29:45 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:29:45 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Default 1
D [14/Mar/2012:16:29:45 -0500] CUPS-Get-Default
D [14/Mar/2012:16:29:45 -0500] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [14/Mar/2012:16:29:45 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 Create-Printer-Subscription 1
D [14/Mar/2012:16:30:01 -0500] Create-Printer-Subscription /
D [14/Mar/2012:16:30:01 -0500] cupsdCreateSubscription(con=0x7fd1b0f0a4e0(16), uri="/")
D [14/Mar/2012:16:30:01 -0500] pullmethod="ippget"
D [14/Mar/2012:16:30:01 -0500] notify-lease-duration=86400
D [14/Mar/2012:16:30:01 -0500] notify-time-interval=0
D [14/Mar/2012:16:30:01 -0500] cupsdAddSubscription(mask=1798f, dest=(nil)(), job=(nil)(0), uri="(null)")
D [14/Mar/2012:16:30:01 -0500] Added subscription #22 for server.
D [14/Mar/2012:16:30:01 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:30:01 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:30:01 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAcceptClient: 18 from localhost (Domain)
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 18 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 18 1.1 Get-Printer-Attributes 1
D [14/Mar/2012:16:30:01 -0500] Get-Printer-Attributes ipp://localhost/printers/DCP-7020
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/DCP-7020) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 18 WAITING Closing on EOF
D [14/Mar/2012:16:30:01 -0500] cupsdCloseClient: 18
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAcceptClient: 18 from localhost (Domain)
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 18 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 18 1.1 Get-Printer-Attributes 1
D [14/Mar/2012:16:30:01 -0500] Get-Printer-Attributes ipp://localhost/printers/MFC-8680DN
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/MFC-8680DN) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 18 WAITING Closing on EOF
D [14/Mar/2012:16:30:01 -0500] cupsdCloseClient: 18
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:01 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 Create-Printer-Subscription 1
D [14/Mar/2012:16:30:01 -0500] Create-Printer-Subscription /
D [14/Mar/2012:16:30:01 -0500] cupsdCreateSubscription(con=0x7fd1b0f0a4e0(16), uri="/")
D [14/Mar/2012:16:30:01 -0500] pullmethod="ippget"
D [14/Mar/2012:16:30:01 -0500] notify-lease-duration=86400
D [14/Mar/2012:16:30:01 -0500] notify-time-interval=0
D [14/Mar/2012:16:30:01 -0500] cupsdAddSubscription(mask=1798f, dest=(nil)(), job=(nil)(0), uri="(null)")
D [14/Mar/2012:16:30:01 -0500] Added subscription #23 for server.
D [14/Mar/2012:16:30:01 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:30:01 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:30:01 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:01 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 Get-Jobs 1
D [14/Mar/2012:16:30:01 -0500] Get-Jobs ipp://localhost/printers/
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:01 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 1.1 Get-Jobs 1
D [14/Mar/2012:16:30:01 -0500] Get-Jobs ipp://localhost/printers/
D [14/Mar/2012:16:30:01 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:01 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:01 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:02 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:03 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:03 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:03 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:03 -0500] cupsdReadClient: 16 1.1 Get-Notifications 1
D [14/Mar/2012:16:30:03 -0500] Get-Notifications /
D [14/Mar/2012:16:30:03 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:30:03 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:30:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:03 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:03 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:03 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:03 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:03 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:03 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:03 -0500] cupsdReadClient: 16 1.1 Get-Notifications 1
D [14/Mar/2012:16:30:03 -0500] Get-Notifications /
D [14/Mar/2012:16:30:03 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:30:03 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:30:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:03 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:03 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:03 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:08 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:08 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:08 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:08 -0500] cupsdReadClient: 16 1.1 Cancel-Subscription 1
D [14/Mar/2012:16:30:08 -0500] Cancel-Subscription /
D [14/Mar/2012:16:30:08 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:30:08 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:08 -0500] Returning IPP successful-ok for Cancel-Subscription (/) from localhost
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:08 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:08 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:08 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:08 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:08 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:08 -0500] cupsdReadClient: 16 1.1 Cancel-Subscription 1
D [14/Mar/2012:16:30:08 -0500] Cancel-Subscription /
D [14/Mar/2012:16:30:08 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:30:08 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:08 -0500] Returning IPP successful-ok for Cancel-Subscription (/) from localhost
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:08 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:08 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:08 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [14/Mar/2012:16:30:15 -0500] Saving job.cache...
I [14/Mar/2012:16:30:15 -0500] Saving subscriptions.conf...
D [14/Mar/2012:16:30:15 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [14/Mar/2012:16:30:18 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:30:18 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:30:18 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:30:18 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:30:18 -0500] cupsdReadClient: 16 1.1 Cancel-Subscription 1
D [14/Mar/2012:16:30:18 -0500] Cancel-Subscription /
D [14/Mar/2012:16:30:18 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:30:18 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:30:18 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [14/Mar/2012:16:30:18 -0500] Returning IPP successful-ok for Cancel-Subscription (/) from localhost
D [14/Mar/2012:16:30:18 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:30:18 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:30:18 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:30:18 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:19 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:30:19 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:30:19 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:30:19 -0500] cupsdReadClient: 19 WAITING Closing on EOF
D [14/Mar/2012:16:30:19 -0500] cupsdCloseClient: 19
D [14/Mar/2012:16:30:19 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [14/Mar/2012:16:30:49 -0500] Saving subscriptions.conf...
D [14/Mar/2012:16:30:49 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [14/Mar/2012:16:30:49 -0500] [Job 28] Unloading...
D [14/Mar/2012:16:30:49 -0500] Report: clients=1
D [14/Mar/2012:16:30:49 -0500] Report: jobs=15
D [14/Mar/2012:16:30:49 -0500] Report: jobs-active=0
D [14/Mar/2012:16:30:49 -0500] Report: printers=2
D [14/Mar/2012:16:30:49 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:30:49 -0500] Report: stringpool-string-count=7655
D [14/Mar/2012:16:30:49 -0500] Report: stringpool-alloc-bytes=15168
D [14/Mar/2012:16:30:49 -0500] Report: stringpool-total-bytes=139360
D [14/Mar/2012:16:34:23 -0500] Report: clients=1
D [14/Mar/2012:16:34:23 -0500] Report: jobs=15
D [14/Mar/2012:16:34:23 -0500] Report: jobs-active=0
D [14/Mar/2012:16:34:23 -0500] Report: printers=2
D [14/Mar/2012:16:34:23 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:34:23 -0500] Report: stringpool-string-count=7655
D [14/Mar/2012:16:34:23 -0500] Report: stringpool-alloc-bytes=15168
D [14/Mar/2012:16:34:23 -0500] Report: stringpool-total-bytes=139360
D [14/Mar/2012:16:34:23 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:34:23 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:34:23 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:34:23 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:34:23 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:34:23 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:34:23 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:34:23 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:34:30 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:34:30 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:34:30 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:34:46 -0500] Closing client 17 after 300 seconds of inactivity...
D [14/Mar/2012:16:34:46 -0500] cupsdCloseClient: 17
D [14/Mar/2012:16:34:46 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:36:08 -0500] Report: clients=0
D [14/Mar/2012:16:36:08 -0500] Report: jobs=15
D [14/Mar/2012:16:36:08 -0500] Report: jobs-active=0
D [14/Mar/2012:16:36:08 -0500] Report: printers=2
D [14/Mar/2012:16:36:08 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:36:08 -0500] Report: stringpool-string-count=7655
D [14/Mar/2012:16:36:08 -0500] Report: stringpool-alloc-bytes=15168
D [14/Mar/2012:16:36:08 -0500] Report: stringpool-total-bytes=139360
D [14/Mar/2012:16:36:08 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:36:08 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:36:08 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:36:08 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:36:08 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:36:08 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:36:08 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:36:08 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:36:11 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:36:11 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:36:11 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:37:01 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:37:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:37:01 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:37:01 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:37:01 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:37:01 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 POST /admin/ HTTP/1.1
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:37:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 1.1 Pause-Printer 1
D [14/Mar/2012:16:37:01 -0500] Pause-Printer ipp://localhost:631/printers/DCP-7020
D [14/Mar/2012:16:37:01 -0500] cupsdIsAuthorized: username=""
D [14/Mar/2012:16:37:01 -0500] Returning HTTP Unauthorized for Pause-Printer (ipp://localhost:631/printers/DCP-7020) from localhost
D [14/Mar/2012:16:37:01 -0500] cupsdSendHeader: 14 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:37:01 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:37:01 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:37:01 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:37:01 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 POST /admin/ HTTP/1.1
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:37:01 -0500] cupsdAuthorize: Authorized as root using PeerCred
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 1.1 Pause-Printer 1
D [14/Mar/2012:16:37:01 -0500] Pause-Printer ipp://localhost:631/printers/DCP-7020
D [14/Mar/2012:16:37:01 -0500] cupsdIsAuthorized: username="root"
D [14/Mar/2012:16:37:01 -0500] cupsdMarkDirty(-----S)
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [14/Mar/2012:16:37:01 -0500] cupsdMarkDirty(P-----)
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:37:01 -0500] cupsdRegisterPrinter(p=0x7fd1b0e5ca80(DCP-7020))
D [14/Mar/2012:16:37:01 -0500] cupsdMarkDirty(P-----)
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [14/Mar/2012:16:37:01 -0500] Printer "DCP-7020" stopped by "root".
D [14/Mar/2012:16:37:01 -0500] Returning IPP successful-ok for Pause-Printer (ipp://localhost:631/printers/DCP-7020) from localhost
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:37:01 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [14/Mar/2012:16:37:01 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [14/Mar/2012:16:37:01 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 1.1 Get-Notifications 1
D [14/Mar/2012:16:37:01 -0500] Get-Notifications /
D [14/Mar/2012:16:37:01 -0500] cupsdIsAuthorized: requesting-user-name="bruce"
D [14/Mar/2012:16:37:01 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [14/Mar/2012:16:37:01 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:37:01 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:37:01 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [14/Mar/2012:16:37:32 -0500] Saving printers.conf...
I [14/Mar/2012:16:37:32 -0500] Saving subscriptions.conf...
D [14/Mar/2012:16:37:32 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [14/Mar/2012:16:37:32 -0500] Report: clients=0
D [14/Mar/2012:16:37:32 -0500] Report: jobs=15
D [14/Mar/2012:16:37:32 -0500] Report: jobs-active=0
D [14/Mar/2012:16:37:32 -0500] Report: printers=2
D [14/Mar/2012:16:37:32 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:37:32 -0500] Report: stringpool-string-count=7694
D [14/Mar/2012:16:37:32 -0500] Report: stringpool-alloc-bytes=15248
D [14/Mar/2012:16:37:32 -0500] Report: stringpool-total-bytes=140152
D [14/Mar/2012:16:38:19 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:38:19 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:38:19 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:38:19 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:38:19 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:38:19 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:38:19 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:38:19 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:38:19 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:38:19 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:38:19 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:39:51 -0500] Report: clients=0
D [14/Mar/2012:16:39:51 -0500] Report: jobs=15
D [14/Mar/2012:16:39:51 -0500] Report: jobs-active=0
D [14/Mar/2012:16:39:51 -0500] Report: printers=2
D [14/Mar/2012:16:39:51 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:39:51 -0500] Report: stringpool-string-count=7694
D [14/Mar/2012:16:39:51 -0500] Report: stringpool-alloc-bytes=15248
D [14/Mar/2012:16:39:51 -0500] Report: stringpool-total-bytes=140152
D [14/Mar/2012:16:39:51 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:39:51 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:39:51 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:39:51 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:39:51 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:39:51 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:39:51 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:39:51 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:39:51 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:16:39:51 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:39:51 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:40:40 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:16:40:40 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:16:40:40 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:40:40 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:40:40 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:40:40 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:40:40 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:40:40 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:41:55 -0500] Report: clients=1
D [14/Mar/2012:16:41:55 -0500] Report: jobs=15
D [14/Mar/2012:16:41:55 -0500] Report: jobs-active=0
D [14/Mar/2012:16:41:55 -0500] Report: printers=2
D [14/Mar/2012:16:41:55 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:41:55 -0500] Report: stringpool-string-count=7694
D [14/Mar/2012:16:41:55 -0500] Report: stringpool-alloc-bytes=15248
D [14/Mar/2012:16:41:55 -0500] Report: stringpool-total-bytes=140152
D [14/Mar/2012:16:43:10 -0500] Report: clients=1
D [14/Mar/2012:16:43:10 -0500] Report: jobs=15
D [14/Mar/2012:16:43:10 -0500] Report: jobs-active=0
D [14/Mar/2012:16:43:10 -0500] Report: printers=2
D [14/Mar/2012:16:43:10 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:43:10 -0500] Report: stringpool-string-count=7694
D [14/Mar/2012:16:43:10 -0500] Report: stringpool-alloc-bytes=15248
D [14/Mar/2012:16:43:10 -0500] Report: stringpool-total-bytes=140152
D [14/Mar/2012:16:43:49 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:43:49 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:43:49 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:43:49 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:43:49 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:43:49 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:43:49 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:43:49 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:44:05 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:44:05 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:44:05 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:44:23 -0500] Report: clients=1
D [14/Mar/2012:16:44:23 -0500] Report: jobs=15
D [14/Mar/2012:16:44:23 -0500] Report: jobs-active=0
D [14/Mar/2012:16:44:23 -0500] Report: printers=2
D [14/Mar/2012:16:44:23 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:44:23 -0500] Report: stringpool-string-count=7694
D [14/Mar/2012:16:44:23 -0500] Report: stringpool-alloc-bytes=15248
D [14/Mar/2012:16:44:23 -0500] Report: stringpool-total-bytes=140152
D [14/Mar/2012:16:44:23 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [14/Mar/2012:16:44:23 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [14/Mar/2012:16:44:23 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:16:44:23 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:16:44:23 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:16:44:23 -0500] CUPS-Get-Printers
D [14/Mar/2012:16:44:23 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:16:44:23 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:16:44:26 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [14/Mar/2012:16:44:26 -0500] cupsdCloseClient: 16
D [14/Mar/2012:16:44:26 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:45:41 -0500] Closing client 14 after 300 seconds of inactivity...
D [14/Mar/2012:16:45:41 -0500] cupsdCloseClient: 14
D [14/Mar/2012:16:45:41 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:45:41 -0500] Report: clients=0
D [14/Mar/2012:16:45:41 -0500] Report: jobs=15
D [14/Mar/2012:16:45:41 -0500] Report: jobs-active=0
D [14/Mar/2012:16:45:41 -0500] Report: printers=2
D [14/Mar/2012:16:45:41 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:45:41 -0500] Report: stringpool-string-count=7694
D [14/Mar/2012:16:45:41 -0500] Report: stringpool-alloc-bytes=15248
D [14/Mar/2012:16:45:41 -0500] Report: stringpool-total-bytes=140152
I [14/Mar/2012:16:45:58 -0500] Scheduler shutting down normally.
D [14/Mar/2012:16:45:58 -0500] Discarding unused server-stopped event...
I [14/Mar/2012:16:45:58 -0500] Saving job.cache...
I [14/Mar/2012:16:59:45 -0500] Remote access is disabled.
D [14/Mar/2012:16:59:45 -0500] Added auto ServerAlias amati
I [14/Mar/2012:16:59:45 -0500] Loaded configuration file "/etc/cups/cupsd.conf"
D [14/Mar/2012:16:59:45 -0500] Repairing ownership of "/var/run/cups"
D [14/Mar/2012:16:59:45 -0500] Repairing ownership of "/var/run/cups/certs"
D [14/Mar/2012:16:59:45 -0500] Repairing access permissions of "/var/run/cups/certs"
I [14/Mar/2012:16:59:45 -0500] Using default TempDir of /var/spool/cups/tmp...
I [14/Mar/2012:16:59:45 -0500] Configured for up to 100 clients.
I [14/Mar/2012:16:59:45 -0500] Allowing up to 100 client connections per host.
I [14/Mar/2012:16:59:45 -0500] Using policy "default" as the default.
I [14/Mar/2012:16:59:45 -0500] Full reload is required.
I [14/Mar/2012:16:59:45 -0500] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 38 types, 56 filters...
D [14/Mar/2012:16:59:45 -0500] Loading printer DCP-7020...
D [14/Mar/2012:16:59:45 -0500] load_ppd: Loading /var/cache/cups/DCP-7020.data...
D [14/Mar/2012:16:59:45 -0500] Calling DeleteDevice(cups-DCP-7020)
D [14/Mar/2012:16:59:45 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:59:45 -0500] Using profile id of DCP-7020-Gray..
D [14/Mar/2012:16:59:45 -0500] Calling CreateProfile(DCP-7020-Gray..,temp)
D [14/Mar/2012:16:59:48 -0500] created profile /org/freedesktop/ColorManager/profiles/DCP_7020_Gray__
I [14/Mar/2012:16:59:48 -0500] Registering ICC color profiles for "DCP-7020"
D [14/Mar/2012:16:59:48 -0500] Calling CreateDevice(cups-DCP-7020,temp)
D [14/Mar/2012:16:59:48 -0500] created device /org/freedesktop/ColorManager/devices/cups_DCP_7020
D [14/Mar/2012:16:59:48 -0500] Calling /org/freedesktop/ColorManager/devices/cups_DCP_7020:AddProfile(/org/freedesktop/ColorManager/profiles/DCP_7020_Gray__) [soft]
D [14/Mar/2012:16:59:48 -0500] cupsdRegisterPrinter(p=0x7f1acc9650a0(DCP-7020))
D [14/Mar/2012:16:59:48 -0500] Loading printer MFC-8680DN...
D [14/Mar/2012:16:59:48 -0500] load_ppd: Loading /var/cache/cups/MFC-8680DN.data...
D [14/Mar/2012:16:59:48 -0500] Calling DeleteDevice(cups-MFC-8680DN)
D [14/Mar/2012:16:59:48 -0500] failed to DeleteDevice: org.freedesktop.DBus.Error.InvalidArgs:Type of message, `(s)', does not match expected type `(o)'
D [14/Mar/2012:16:59:48 -0500] Using profile id of MFC-8680DN-Gray..
D [14/Mar/2012:16:59:48 -0500] Calling CreateProfile(MFC-8680DN-Gray..,temp)
D [14/Mar/2012:16:59:48 -0500] created profile /org/freedesktop/ColorManager/profiles/MFC_8680DN_Gray__
I [14/Mar/2012:16:59:48 -0500] Registering ICC color profiles for "MFC-8680DN"
D [14/Mar/2012:16:59:48 -0500] Calling CreateDevice(cups-MFC-8680DN,temp)
D [14/Mar/2012:16:59:48 -0500] created device /org/freedesktop/ColorManager/devices/cups_MFC_8680DN
D [14/Mar/2012:16:59:48 -0500] Calling /org/freedesktop/ColorManager/devices/cups_MFC_8680DN:AddProfile(/org/freedesktop/ColorManager/profiles/MFC_8680DN_Gray__) [soft]
D [14/Mar/2012:16:59:48 -0500] cupsdRegisterPrinter(p=0x7f1acc9c8cd0(MFC-8680DN))
D [14/Mar/2012:16:59:48 -0500] cupsdLoadRemoteCache: Not loading remote cache.
I [14/Mar/2012:16:59:48 -0500] Generating printcap /var/run/cups/printcap...
I [14/Mar/2012:16:59:48 -0500] Loading job cache file "/var/cache/cups/job.cache"...
D [14/Mar/2012:16:59:48 -0500] [Job 13] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 15] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 16] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 17] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 18] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 19] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 20] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 21] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 22] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 23] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 24] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 25] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 26] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 27] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] [Job 28] Loading from cache...
D [14/Mar/2012:16:59:48 -0500] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [14/Mar/2012:16:59:48 -0500] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [14/Mar/2012:16:59:48 -0500] Full reload complete.
D [14/Mar/2012:16:59:48 -0500] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [14/Mar/2012:16:59:48 -0500] Cleaning out old files in "/var/spool/cups/tmp"...
D [14/Mar/2012:16:59:48 -0500] cupsdCleanFiles(path="/var/spool/cups/tmp/.hplip", pattern="(null)")
I [14/Mar/2012:16:59:48 -0500] Cleaning out old files in "/var/spool/cups/tmp/.hplip"...
D [14/Mar/2012:16:59:48 -0500] Removed "/var/spool/cups/tmp/.hplip/hplip.conf"...
D [14/Mar/2012:16:59:48 -0500] Removed "/var/spool/cups/tmp/.hplip"...
D [14/Mar/2012:16:59:48 -0500] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [14/Mar/2012:16:59:48 -0500] Cleaning out old files in "/var/cache/cups"...
I [14/Mar/2012:16:59:48 -0500] Listening to [v1.::1]:631 on fd 9...
I [14/Mar/2012:16:59:48 -0500] Listening to 127.0.0.1:631 on fd 10...
I [14/Mar/2012:16:59:48 -0500] Listening to /var/run/cups/cups.sock:631 on fd 11...
I [14/Mar/2012:16:59:48 -0500] Resuming new connection processing...
D [14/Mar/2012:16:59:48 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:16:59:48 -0500] Discarding unused server-started event...
D [14/Mar/2012:16:59:49 -0500] Report: clients=0
D [14/Mar/2012:16:59:49 -0500] Report: jobs=15
D [14/Mar/2012:16:59:49 -0500] Report: jobs-active=0
D [14/Mar/2012:16:59:49 -0500] Report: printers=2
D [14/Mar/2012:16:59:49 -0500] Report: printers-implicit=0
D [14/Mar/2012:16:59:49 -0500] Report: stringpool-string-count=5132
D [14/Mar/2012:16:59:49 -0500] Report: stringpool-alloc-bytes=9944
D [14/Mar/2012:16:59:49 -0500] Report: stringpool-total-bytes=93400
D [14/Mar/2012:17:00:18 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:17:00:18 -0500] Avahi client started
D [14/Mar/2012:17:00:18 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:17:00:18 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:17:00:18 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:17:00:18 -0500] cupsdReadClient: 14 1.1 Get-Jobs 1
D [14/Mar/2012:17:00:18 -0500] Get-Jobs ipp://localhost/printers/
D [14/Mar/2012:17:00:18 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [14/Mar/2012:17:00:18 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:17:00:18 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:17:00:18 -0500] cupsdCloseClient: 14
D [14/Mar/2012:17:00:18 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [14/Mar/2012:17:00:22 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [14/Mar/2012:17:00:22 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [14/Mar/2012:17:00:22 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [14/Mar/2012:17:00:22 -0500] cupsdAuthorize: No authentication data provided.
D [14/Mar/2012:17:00:22 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [14/Mar/2012:17:00:22 -0500] CUPS-Get-Printers
D [14/Mar/2012:17:00:22 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [14/Mar/2012:17:00:22 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [14/Mar/2012:17:00:49 -0500] Report: clients=1
D [14/Mar/2012:17:00:49 -0500] Report: jobs=15
D [14/Mar/2012:17:00:49 -0500] Report: jobs-active=0
D [14/Mar/2012:17:00:49 -0500] Report: printers=2
D [14/Mar/2012:17:00:49 -0500] Report: printers-implicit=0
D [14/Mar/2012:17:00:49 -0500] Report: stringpool-string-count=5132
D [14/Mar/2012:17:00:49 -0500] Report: stringpool-alloc-bytes=9944
D [14/Mar/2012:17:00:49 -0500] Report: stringpool-total-bytes=93400
D [14/Mar/2012:17:01:51 -0500] Report: clients=1
D [14/Mar/2012:17:01:51 -0500] Report: jobs=15
D [14/Mar/2012:17:01:51 -0500] Report: jobs-active=0
D [14/Mar/2012:17:01:51 -0500] Report: printers=2
D [14/Mar/2012:17:01:51 -0500] Report: printers-implicit=0
D [14/Mar/2012:17:01:51 -0500] Report: stringpool-string-count=5132
D [14/Mar/2012:17:01:51 -0500] Report: stringpool-alloc-bytes=9944
D [14/Mar/2012:17:01:51 -0500] Report: stringpool-total-bytes=93400
D [14/Mar/2012:17:01:51 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [14/Mar/2012:17:01:51 -0500] cupsdCloseClient: 14
D [14/Mar/2012:17:01:51 -0500] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"