Bug#758665: cups-browsed: Causes the cups daemon to continually restart

To: Debian Bug Tracking System <submit@bugs.debian.org>
Subject: Bug#758665: cups-browsed: Causes the cups daemon to continually restart
From: Brian Potkin <claremont102@gmail.com>
Date: Tue, 19 Aug 2014 19:54:35 +0100
Message-id: <[🔎] 19082014185249.b1927409e07d@desktop.copernicus.demon.co.uk>
Reply-to: Brian Potkin <claremont102@gmail.com>, 758665@bugs.debian.org

Package: cups-browsed
Version: 1.0.57-1
Severity: normal



This machine started out yesterday with a cups installation without its
recommended packages. cups-browsed was installed (with Recommends:).
cupsd.conf has 'IdleExitTime 20'.

After 'systemctl restart cups.service' or printing to a queue the status
of cups was monitored with 'systemctl status cups'. Sure enough cups
became inactive after 20s (near enough).

Today there was a cups-browsed update which was installed with apt-get.

I'm now seeing this:

  root@testing:~# systemctl status cups
  cups.service - CUPS Printing Service
     Loaded: loaded (/lib/systemd/system/cups.service; enabled)
     Active: active (running) since Tue 2014-08-19 19:07:48 BST; 1s ago
       Docs: man:cupsd(8)
             man:cupsd.conf(5)
   Main PID: 5713 (cupsd)
     CGroup: /system.slice/cups.service
             └─5713 /usr/sbin/cupsd -f

  Aug 19 19:07:48 testing systemd[1]: Started CUPS Printing Service.
  root@testing:~# systemctl status cups
  cups.service - CUPS Printing Service
     Loaded: loaded (/lib/systemd/system/cups.service; enabled)
     Active: inactive (dead) since Tue 2014-08-19 19:08:11 BST; 2s ago
       Docs: man:cupsd(8)
             man:cupsd.conf(5)
    Process: 5713 ExecStart=/usr/sbin/cupsd -f (code=exited, status=0/SUCCESS)
   Main PID: 5713 (code=exited, status=0/SUCCESS)

  Aug 19 19:07:48 testing systemd[1]: Started CUPS Printing Service.
  root@testing:~# systemctl status cups
  cups.service - CUPS Printing Service
     Loaded: loaded (/lib/systemd/system/cups.service; enabled)
     Active: active (running) since Tue 2014-08-19 19:08:19 BST; 3s ago
       Docs: man:cupsd(8)
             man:cupsd.conf(5)
   Main PID: 5721 (cupsd)
     CGroup: /system.slice/cups.service
             └─5721 /usr/sbin/cupsd -f

  Aug 19 19:08:19 testing systemd[1]: Started CUPS Printing Service.

The daemon is active for 23s. inactive for 8s and then becomes active
again. This sequence has been going on for the past 15 minutes. Printing
does not alter this behaviour.

There is an error_log attached. It starts by showing cups listening. It
then promises to shutdown:

  D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
  D [19/Aug/2014:19:35:46 +0100] cupsd is idle, scheduling shutdown in 20 seconds.

It keeps its promise 21 seconds later:

  I [19/Aug/2014:19:36:07 +0100] Printer sharing is off and there are no jobs pending, shutting down for now.
  I [19/Aug/2014:19:36:07 +0100] Scheduler shutting down normally.

Then something causes it to start listening again 8 seconds later:

  I [19/Aug/2014:19:36:15 +0100] Listening to [v1.::1]:631 (IPv6)
  I [19/Aug/2014:19:36:15 +0100] Listening to 127.0.0.1:631 (IPv4)
  I [19/Aug/2014:19:36:15 +0100] Listening to /var/run/cups/cups.sock (Domain)

Regards,

Brian.

I [19/Aug/2014:19:35:44 +0100] Listening to [v1.::1]:631 (IPv6)
I [19/Aug/2014:19:35:44 +0100] Listening to 127.0.0.1:631 (IPv4)
I [19/Aug/2014:19:35:44 +0100] Listening to /var/run/cups/cups.sock (Domain)
I [19/Aug/2014:19:35:44 +0100] Remote access is disabled.
D [19/Aug/2014:19:35:44 +0100] Added auto ServerAlias testing
I [19/Aug/2014:19:35:44 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
I [19/Aug/2014:19:35:44 +0100] Using default TempDir of /var/spool/cups/tmp...
I [19/Aug/2014:19:35:44 +0100] Configured for up to 100 clients.
I [19/Aug/2014:19:35:44 +0100] Allowing up to 100 client connections per host.
I [19/Aug/2014:19:35:44 +0100] Using policy "default" as the default.
I [19/Aug/2014:19:35:44 +0100] Full reload is required.
I [19/Aug/2014:19:35:44 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 39 types, 53 filters...
D [19/Aug/2014:19:35:44 +0100] Loading printer Colour...
D [19/Aug/2014:19:35:44 +0100] cupsdMarkDirty(P----)
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
D [19/Aug/2014:19:35:44 +0100] load_ppd: Loading /etc/cups/ppd/Colour.ppd...
D [19/Aug/2014:19:35:44 +0100] cupsdRegisterPrinter(p=0xb7bf4b68(Colour))
D [19/Aug/2014:19:35:44 +0100] Loading printer LaserJet-300...
D [19/Aug/2014:19:35:44 +0100] cupsdMarkDirty(P----)
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:44 +0100] load_ppd: Loading /etc/cups/ppd/LaserJet-300.ppd...
D [19/Aug/2014:19:35:44 +0100] cupsdRegisterPrinter(p=0xb7bf7c30(LaserJet-300))
D [19/Aug/2014:19:35:44 +0100] Loading printer LaserJet-600...
D [19/Aug/2014:19:35:44 +0100] cupsdMarkDirty(P----)
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:44 +0100] load_ppd: Loading /etc/cups/ppd/LaserJet-600.ppd...
D [19/Aug/2014:19:35:44 +0100] cupsdRegisterPrinter(p=0xb7bf8a18(LaserJet-600))
D [19/Aug/2014:19:35:44 +0100] Loading printer test...
D [19/Aug/2014:19:35:44 +0100] load_ppd: Loading /var/cache/cups/test.data...
D [19/Aug/2014:19:35:44 +0100] cupsdRegisterPrinter(p=0xb7bf97c8(test))
I [19/Aug/2014:19:35:44 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [19/Aug/2014:19:35:44 +0100] [Job 1] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 2] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 3] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 4] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 5] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 6] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 7] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 8] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 9] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 10] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 11] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 12] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 13] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 14] Loading from cache...
D [19/Aug/2014:19:35:44 +0100] [Job 15] Loading from cache...
I [19/Aug/2014:19:35:44 +0100] Full reload complete.
D [19/Aug/2014:19:35:44 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [19/Aug/2014:19:35:44 +0100] Cleaning out old files in "/var/spool/cups/tmp".
D [19/Aug/2014:19:35:44 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [19/Aug/2014:19:35:44 +0100] Cleaning out old files in "/var/cache/cups".
D [19/Aug/2014:19:35:44 +0100] systemd_checkin: Matched existing listener /var/run/cups/cups.sock with fd 3...
D [19/Aug/2014:19:35:44 +0100] systemd_checkin: Matched existing listener 127.0.0.1 with fd 4...
D [19/Aug/2014:19:35:44 +0100] systemd_checkin: Matched existing listener [v1.::1] with fd 5...
D [19/Aug/2014:19:35:44 +0100] systemd_checkin: Activate exit-on-idle mode, timeout: 20 seconds.
D [19/Aug/2014:19:35:44 +0100] Calling FindDeviceById(cups-Colour)
D [19/Aug/2014:19:35:44 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:35:44 +0100] Calling FindDeviceById(cups-LaserJet-300)
D [19/Aug/2014:19:35:44 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:35:44 +0100] Calling FindDeviceById(cups-LaserJet-600)
D [19/Aug/2014:19:35:44 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:35:44 +0100] Calling FindDeviceById(cups-test)
D [19/Aug/2014:19:35:44 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:35:44 +0100] Using profile ID "test-Gray..".
D [19/Aug/2014:19:35:44 +0100] Calling CreateProfile(test-Gray..,temp)
W [19/Aug/2014:19:35:44 +0100] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:35:44 +0100] Using profile ID "test-RGB..".
D [19/Aug/2014:19:35:44 +0100] Calling CreateProfile(test-RGB..,temp)
W [19/Aug/2014:19:35:44 +0100] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Aug/2014:19:35:44 +0100] Registering ICC color profiles for "test".
D [19/Aug/2014:19:35:44 +0100] Calling CreateDevice(cups-test,temp)
W [19/Aug/2014:19:35:44 +0100] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Aug/2014:19:35:44 +0100] Listening to [v1.::1]:631 on fd 5...
I [19/Aug/2014:19:35:44 +0100] Listening to 127.0.0.1:631 on fd 4...
I [19/Aug/2014:19:35:44 +0100] Listening to /var/run/cups/cups.sock:631 on fd 3...
I [19/Aug/2014:19:35:44 +0100] Resuming new connection processing...
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:44 +0100] Discarding unused server-started event...
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] [Client 14] Accepted from localhost:631 (IPv6)
D [19/Aug/2014:19:35:44 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:35:44 +0100] Report: clients=1
D [19/Aug/2014:19:35:44 +0100] Report: jobs=15
D [19/Aug/2014:19:35:44 +0100] Report: jobs-active=0
D [19/Aug/2014:19:35:44 +0100] Report: printers=4
D [19/Aug/2014:19:35:44 +0100] Report: stringpool-string-count=1189
D [19/Aug/2014:19:35:44 +0100] Report: stringpool-alloc-bytes=9584
D [19/Aug/2014:19:35:44 +0100] Report: stringpool-total-bytes=22360
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:44 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:35:44 +0100] [Client 14] 2.0 CUPS-Get-Printers 774
D [19/Aug/2014:19:35:44 +0100] CUPS-Get-Printers
D [19/Aug/2014:19:35:44 +0100] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [19/Aug/2014:19:35:44 +0100] [Client 14] Content-Length: 3429
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3429, response=0xb7c3dda0(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:35:44 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:35:44 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:35:44 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:44 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] [Client 14] 2.0 CUPS-Get-Default 775
D [19/Aug/2014:19:35:44 +0100] CUPS-Get-Default
D [19/Aug/2014:19:35:44 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [19/Aug/2014:19:35:44 +0100] [Client 14] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [19/Aug/2014:19:35:44 +0100] [Client 14] Content-Length: 113
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:44 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb7c3db70(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:35:44 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:35:44 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:35:44 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:35:44 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:35:44 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:35:45 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:45 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] [Client 14] 2.0 CUPS-Get-Printers 776
D [19/Aug/2014:19:35:45 +0100] CUPS-Get-Printers
D [19/Aug/2014:19:35:45 +0100] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [19/Aug/2014:19:35:45 +0100] [Client 14] Content-Length: 3429
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3429, response=0xb7c3de10(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:35:45 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:35:45 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:35:45 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:35:45 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:35:45 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:45 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] [Client 14] 2.0 CUPS-Get-Default 777
D [19/Aug/2014:19:35:45 +0100] CUPS-Get-Default
D [19/Aug/2014:19:35:45 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [19/Aug/2014:19:35:45 +0100] [Client 14] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [19/Aug/2014:19:35:45 +0100] [Client 14] Content-Length: 113
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:45 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb7c3f300(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:35:45 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:35:45 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:35:45 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:35:45 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:35:45 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is idle, scheduling shutdown in 20 seconds.
D [19/Aug/2014:19:35:46 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:35:46 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:46 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] [Client 14] 2.0 CUPS-Get-Printers 778
D [19/Aug/2014:19:35:46 +0100] CUPS-Get-Printers
D [19/Aug/2014:19:35:46 +0100] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [19/Aug/2014:19:35:46 +0100] [Client 14] Content-Length: 3429
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3429, response=0xb7c3ddd8(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:35:46 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:35:46 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:35:46 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:35:46 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:35:46 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:35:46 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] [Client 14] 2.0 CUPS-Get-Default 779
D [19/Aug/2014:19:35:46 +0100] CUPS-Get-Default
D [19/Aug/2014:19:35:46 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [19/Aug/2014:19:35:46 +0100] [Client 14] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [19/Aug/2014:19:35:46 +0100] [Client 14] Content-Length: 113
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:46 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb7c3f300(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:35:46 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:35:46 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:35:46 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:35:46 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:35:46 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:35:47 +0100] cupsd is idle, scheduling shutdown in 20 seconds.
I [19/Aug/2014:19:36:07 +0100] Printer sharing is off and there are no jobs pending, shutting down for now.
I [19/Aug/2014:19:36:07 +0100] Scheduler shutting down normally.
D [19/Aug/2014:19:36:07 +0100] Discarding unused server-stopped event...
D [19/Aug/2014:19:36:07 +0100] [Client 14] Closing connection.
D [19/Aug/2014:19:36:07 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [19/Aug/2014:19:36:07 +0100] Saving printers.conf...
D [19/Aug/2014:19:36:07 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
I [19/Aug/2014:19:36:07 +0100] Saving job.cache...
D [19/Aug/2014:19:36:07 +0100] cupsdStopSelect()
I [19/Aug/2014:19:36:15 +0100] Listening to [v1.::1]:631 (IPv6)
I [19/Aug/2014:19:36:15 +0100] Listening to 127.0.0.1:631 (IPv4)
I [19/Aug/2014:19:36:15 +0100] Listening to /var/run/cups/cups.sock (Domain)
I [19/Aug/2014:19:36:15 +0100] Remote access is disabled.
D [19/Aug/2014:19:36:15 +0100] Added auto ServerAlias testing
I [19/Aug/2014:19:36:15 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
I [19/Aug/2014:19:36:15 +0100] Using default TempDir of /var/spool/cups/tmp...
I [19/Aug/2014:19:36:15 +0100] Configured for up to 100 clients.
I [19/Aug/2014:19:36:15 +0100] Allowing up to 100 client connections per host.
I [19/Aug/2014:19:36:15 +0100] Using policy "default" as the default.
I [19/Aug/2014:19:36:15 +0100] Full reload is required.
I [19/Aug/2014:19:36:15 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 39 types, 53 filters...
D [19/Aug/2014:19:36:15 +0100] Loading printer Colour...
D [19/Aug/2014:19:36:15 +0100] cupsdMarkDirty(P----)
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Not busy"
D [19/Aug/2014:19:36:15 +0100] load_ppd: Loading /etc/cups/ppd/Colour.ppd...
D [19/Aug/2014:19:36:15 +0100] cupsdRegisterPrinter(p=0xb958bb68(Colour))
D [19/Aug/2014:19:36:15 +0100] Loading printer LaserJet-300...
D [19/Aug/2014:19:36:15 +0100] cupsdMarkDirty(P----)
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:15 +0100] load_ppd: Loading /etc/cups/ppd/LaserJet-300.ppd...
D [19/Aug/2014:19:36:15 +0100] cupsdRegisterPrinter(p=0xb958ec30(LaserJet-300))
D [19/Aug/2014:19:36:15 +0100] Loading printer LaserJet-600...
D [19/Aug/2014:19:36:15 +0100] cupsdMarkDirty(P----)
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:15 +0100] load_ppd: Loading /etc/cups/ppd/LaserJet-600.ppd...
D [19/Aug/2014:19:36:15 +0100] cupsdRegisterPrinter(p=0xb958fa18(LaserJet-600))
D [19/Aug/2014:19:36:15 +0100] Loading printer test...
D [19/Aug/2014:19:36:15 +0100] load_ppd: Loading /var/cache/cups/test.data...
D [19/Aug/2014:19:36:15 +0100] cupsdRegisterPrinter(p=0xb95907c8(test))
I [19/Aug/2014:19:36:15 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [19/Aug/2014:19:36:15 +0100] [Job 1] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 2] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 3] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 4] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 5] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 6] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 7] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 8] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 9] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 10] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 11] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 12] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 13] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 14] Loading from cache...
D [19/Aug/2014:19:36:15 +0100] [Job 15] Loading from cache...
I [19/Aug/2014:19:36:15 +0100] Full reload complete.
D [19/Aug/2014:19:36:15 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [19/Aug/2014:19:36:15 +0100] Cleaning out old files in "/var/spool/cups/tmp".
D [19/Aug/2014:19:36:15 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [19/Aug/2014:19:36:15 +0100] Cleaning out old files in "/var/cache/cups".
D [19/Aug/2014:19:36:15 +0100] systemd_checkin: Matched existing listener /var/run/cups/cups.sock with fd 3...
D [19/Aug/2014:19:36:15 +0100] systemd_checkin: Matched existing listener 127.0.0.1 with fd 4...
D [19/Aug/2014:19:36:15 +0100] systemd_checkin: Matched existing listener [v1.::1] with fd 5...
D [19/Aug/2014:19:36:15 +0100] systemd_checkin: Activate exit-on-idle mode, timeout: 20 seconds.
D [19/Aug/2014:19:36:15 +0100] Calling FindDeviceById(cups-Colour)
D [19/Aug/2014:19:36:15 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:36:15 +0100] Calling FindDeviceById(cups-LaserJet-300)
D [19/Aug/2014:19:36:15 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:36:15 +0100] Calling FindDeviceById(cups-LaserJet-600)
D [19/Aug/2014:19:36:15 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:36:15 +0100] Calling FindDeviceById(cups-test)
D [19/Aug/2014:19:36:15 +0100] FindDeviceById failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:36:15 +0100] Using profile ID "test-Gray..".
D [19/Aug/2014:19:36:15 +0100] Calling CreateProfile(test-Gray..,temp)
W [19/Aug/2014:19:36:15 +0100] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
D [19/Aug/2014:19:36:15 +0100] Using profile ID "test-RGB..".
D [19/Aug/2014:19:36:15 +0100] Calling CreateProfile(test-RGB..,temp)
W [19/Aug/2014:19:36:15 +0100] CreateProfile failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Aug/2014:19:36:15 +0100] Registering ICC color profiles for "test".
D [19/Aug/2014:19:36:15 +0100] Calling CreateDevice(cups-test,temp)
W [19/Aug/2014:19:36:15 +0100] CreateDevice failed: org.freedesktop.DBus.Error.ServiceUnknown:The name org.freedesktop.ColorManager was not provided by any .service files
I [19/Aug/2014:19:36:15 +0100] Listening to [v1.::1]:631 on fd 5...
I [19/Aug/2014:19:36:15 +0100] Listening to 127.0.0.1:631 on fd 4...
I [19/Aug/2014:19:36:15 +0100] Listening to /var/run/cups/cups.sock:631 on fd 3...
I [19/Aug/2014:19:36:15 +0100] Resuming new connection processing...
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:15 +0100] Discarding unused server-started event...
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] Accepted from localhost:631 (IPv6)
D [19/Aug/2014:19:36:15 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:36:15 +0100] Report: clients=1
D [19/Aug/2014:19:36:15 +0100] Report: jobs=15
D [19/Aug/2014:19:36:15 +0100] Report: jobs-active=0
D [19/Aug/2014:19:36:15 +0100] Report: printers=4
D [19/Aug/2014:19:36:15 +0100] Report: stringpool-string-count=1189
D [19/Aug/2014:19:36:15 +0100] Report: stringpool-alloc-bytes=9584
D [19/Aug/2014:19:36:15 +0100] Report: stringpool-total-bytes=22360
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:15 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:36:15 +0100] [Client 14] 2.0 CUPS-Get-Printers 780
D [19/Aug/2014:19:36:15 +0100] CUPS-Get-Printers
D [19/Aug/2014:19:36:15 +0100] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [19/Aug/2014:19:36:15 +0100] [Client 14] Content-Length: 3429
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3429, response=0xb95d4da0(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:36:15 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:15 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] 2.0 CUPS-Get-Default 781
D [19/Aug/2014:19:36:15 +0100] CUPS-Get-Default
D [19/Aug/2014:19:36:15 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [19/Aug/2014:19:36:15 +0100] [Client 14] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [19/Aug/2014:19:36:15 +0100] [Client 14] Content-Length: 113
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb95d4b70(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:36:15 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:15 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] 2.0 CUPS-Get-Printers 782
D [19/Aug/2014:19:36:15 +0100] CUPS-Get-Printers
D [19/Aug/2014:19:36:15 +0100] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [19/Aug/2014:19:36:15 +0100] [Client 14] Content-Length: 3429
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3429, response=0xb95d4e10(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:36:15 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:15 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] 2.0 CUPS-Get-Default 783
D [19/Aug/2014:19:36:15 +0100] CUPS-Get-Default
D [19/Aug/2014:19:36:15 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [19/Aug/2014:19:36:15 +0100] [Client 14] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [19/Aug/2014:19:36:15 +0100] [Client 14] Content-Length: 113
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:15 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb95d6300(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:36:15 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:36:15 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:36:15 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:36:15 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:36:16 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:16 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] [Client 14] 2.0 CUPS-Get-Printers 784
D [19/Aug/2014:19:36:16 +0100] CUPS-Get-Printers
D [19/Aug/2014:19:36:16 +0100] [Client 14] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [19/Aug/2014:19:36:16 +0100] [Client 14] Content-Length: 3429
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=3429, response=0xb95d4dd8(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:36:16 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:36:16 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:36:16 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:36:16 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] [Client 14] POST / HTTP/1.1
D [19/Aug/2014:19:36:16 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [19/Aug/2014:19:36:16 +0100] [Client 14] No authentication data provided.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] [Client 14] 2.0 CUPS-Get-Default 785
D [19/Aug/2014:19:36:16 +0100] CUPS-Get-Default
D [19/Aug/2014:19:36:16 +0100] CUPS-Get-Default client-error-not-found: No default printer.
D [19/Aug/2014:19:36:16 +0100] [Client 14] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [19/Aug/2014:19:36:16 +0100] [Client 14] Content-Length: 113
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:16 +0100] [Client 14] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=113, response=0xb95d6300(IPP_IDLE), pipe_pid=0, file=-1
D [19/Aug/2014:19:36:16 +0100] [Client 14] Writing IPP response, ipp_state=DATA, old wused=0, new wused=0
D [19/Aug/2014:19:36:16 +0100] [Client 14] bytes=0, http_state=0, data_remaining=0
D [19/Aug/2014:19:36:16 +0100] [Client 14] Waiting for request.
D [19/Aug/2014:19:36:16 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [19/Aug/2014:19:36:16 +0100] cupsd is not idle any more, canceling shutdown.
D [19/Aug/2014:19:36:17 +0100] cupsd is idle, scheduling shutdown in 20 seconds.
I [19/Aug/2014:19:36:37 +0100] Printer sharing is off and there are no jobs pending, shutting down for now.
I [19/Aug/2014:19:36:37 +0100] Scheduler shutting down normally.
D [19/Aug/2014:19:36:37 +0100] Discarding unused server-stopped event...
D [19/Aug/2014:19:36:37 +0100] [Client 14] Closing connection.
D [19/Aug/2014:19:36:37 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
I [19/Aug/2014:19:36:37 +0100] Saving printers.conf...
D [19/Aug/2014:19:36:37 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
I [19/Aug/2014:19:36:37 +0100] Saving job.cache...
D [19/Aug/2014:19:36:37 +0100] cupsdStopSelect()

Reply to:

Follow-Ups:
- Bug#758665: cups-browsed: Causes the cups daemon to continually restart
  - From: Brian Potkin <claremont102@gmail.com>

Prev by Date: Bug#758626: cups-browsed: uses a lot of CPU on a busy network
Next by Date: Bug#758665: cups-browsed: Causes the cups daemon to continually restart
Previous by thread: Bug#758626: cups-browsed: uses a lot of CPU on a busy network
Next by thread: Bug#758665: cups-browsed: Causes the cups daemon to continually restart
Index(es):
- Date
- Thread