[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

Bug#758284: cups-daemon: IdleExitTimeout is unreliable

Package: cups-daemon
Version: 1.7.4-4
Severity: normal



This machine had a minimal Wheezy and has been updated to testing.
systems-sysv was installed; rebooted and then cups installed without its
Recommends:, A print queue was established and a job sent to the printer.

I=IdleExitTimeout
t=time for cups to become inactive after cups reports 'Job completed'.

For I > 30s, t=I+30.
For I < 30s, t=I.
For I = 30s it appears to be a toss up whether it is I or I+30.


An extract from an error_log for I=50s:

   I [16/Aug/2014:09:57:54 +0100] [Job 3] Job completed.
   D [16/Aug/2014:09:57:54 +0100] cupsdMarkDirty(---J-)
   D [16/Aug/2014:09:57:54 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:09:57:54 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:09:57:54 +0100] Discarding unused printer-state-changed event...
   D [16/Aug/2014:09:57:54 +0100] cupsdMarkDirty(---J-)
   D [16/Aug/2014:09:57:54 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:09:57:54 +0100] cupsdMarkDirty(---J-)
   D [16/Aug/2014:09:57:54 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:09:57:54 +0100] cupsd is not idle any more, canceling shutdown.
   D [16/Aug/2014:09:57:56 +0100] [Job 3] Unloading...
*  D [16/Aug/2014:09:57:56 +0100] cupsd is not idle any more, canceling shutdown.
*  I [16/Aug/2014:09:58:25 +0100] Saving job.cache...
   D [16/Aug/2014:09:58:25 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"
   D [16/Aug/2014:09:58:25 +0100] cupsd is idle, scheduling shutdown in 50 seconds.
   I [16/Aug/2014:09:59:15 +0100] Printer sharing is off and there are no jobs pending, shutting down for now.
   I [16/Aug/2014:09:59:15 +0100] Scheduler shutting down normally.
   D [16/Aug/2014:09:59:15 +0100] Discarding unused server-stopped event...
   I [16/Aug/2014:09:59:15 +0100] Saving job.cache...
   D [16/Aug/2014:09:59:15 +0100] cupsdStopSelect()
   
Please note the almost 30s delay at the lines marked *.


An extract from an error_log for I=20s:

   I [16/Aug/2014:10:06:24 +0100] [Job 4] Job completed.
   D [16/Aug/2014:10:06:24 +0100] cupsdMarkDirty(---J-)
   D [16/Aug/2014:10:06:24 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:10:06:24 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:10:06:24 +0100] Discarding unused printer-state-changed event...
   D [16/Aug/2014:10:06:24 +0100] cupsdMarkDirty(---J-)
   D [16/Aug/2014:10:06:24 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:10:06:24 +0100] cupsdMarkDirty(---J-)
   D [16/Aug/2014:10:06:24 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
   D [16/Aug/2014:10:06:24 +0100] cupsd is not idle any more, canceling shutdown.
   D [16/Aug/2014:10:06:25 +0100] [Job 4] Unloading...
   D [16/Aug/2014:10:06:25 +0100] cupsd is idle, scheduling shutdown in 20 seconds.
   I [16/Aug/2014:10:06:45 +0100] Printer sharing is off and there are no jobs pending, shutting down for now.
   I [16/Aug/2014:10:06:45 +0100] Scheduler shutting down normally.
   D [16/Aug/2014:10:06:45 +0100] Discarding unused server-stopped event...
   I [16/Aug/2014:10:06:45 +0100] Saving job.cache...
   D [16/Aug/2014:10:06:45 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"
   I [16/Aug/2014:10:06:45 +0100] Saving job.cache...
   D [16/Aug/2014:10:06:45 +0100] cupsdStopSelect()

Please note the lack of a 30s delay.


Regards,

Brian.
Reply to: