2011-04-20 09:44:13 +02:00
|
|
|
|
using System;
|
|
|
|
|
using System.Collections.Generic;
|
|
|
|
|
using System.Diagnostics;
|
|
|
|
|
using System.Linq;
|
|
|
|
|
using System.Threading;
|
|
|
|
|
using NLog;
|
|
|
|
|
using NzbDrone.Core.Model.Notification;
|
|
|
|
|
using NzbDrone.Core.Repository;
|
|
|
|
|
using SubSonic.Repository;
|
|
|
|
|
|
|
|
|
|
namespace NzbDrone.Core.Providers.Jobs
|
|
|
|
|
{
|
|
|
|
|
public class JobProvider
|
|
|
|
|
{
|
|
|
|
|
private static readonly Logger Logger = LogManager.GetCurrentClassLogger();
|
|
|
|
|
private readonly IRepository _repository;
|
|
|
|
|
private readonly NotificationProvider _notificationProvider;
|
|
|
|
|
private readonly IEnumerable<IJob> _jobs;
|
|
|
|
|
|
|
|
|
|
private static readonly object ExecutionLock = new object();
|
|
|
|
|
private Thread _jobThread;
|
|
|
|
|
private static bool _isRunning;
|
2011-05-17 09:04:49 +02:00
|
|
|
|
private static readonly List<Tuple<Type, Int32>> Queue = new List<Tuple<Type, int>>();
|
2011-04-20 09:44:13 +02:00
|
|
|
|
|
|
|
|
|
private ProgressNotification _notification;
|
|
|
|
|
|
|
|
|
|
public JobProvider(IRepository repository, NotificationProvider notificationProvider, IEnumerable<IJob> jobs)
|
|
|
|
|
{
|
|
|
|
|
_repository = repository;
|
|
|
|
|
_notificationProvider = notificationProvider;
|
|
|
|
|
_jobs = jobs;
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
public JobProvider() { }
|
|
|
|
|
|
|
|
|
|
|
|
|
|
|
/// <summary>
|
|
|
|
|
/// Returns a list of all registered jobs
|
|
|
|
|
/// </summary>
|
|
|
|
|
/// <returns></returns>
|
|
|
|
|
public virtual List<JobSetting> All()
|
|
|
|
|
{
|
|
|
|
|
return _repository.All<JobSetting>().ToList();
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
/// <summary>
|
|
|
|
|
/// Creates/Updates settings for a job
|
|
|
|
|
/// </summary>
|
|
|
|
|
/// <param name="settings">Settings to be created/updated</param>
|
|
|
|
|
public virtual void SaveSettings(JobSetting settings)
|
|
|
|
|
{
|
|
|
|
|
if (settings.Id == 0)
|
|
|
|
|
{
|
|
|
|
|
Logger.Debug("Adding job settings for {0}", settings.Name);
|
|
|
|
|
_repository.Add(settings);
|
|
|
|
|
}
|
|
|
|
|
else
|
|
|
|
|
{
|
|
|
|
|
Logger.Debug("Updating job settings for {0}", settings.Name);
|
|
|
|
|
_repository.Update(settings);
|
|
|
|
|
}
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
/// <summary>
|
|
|
|
|
/// Iterates through all registered jobs and executed any that are due for an execution.
|
|
|
|
|
/// </summary>
|
|
|
|
|
/// <returns>True if ran, false if skipped</returns>
|
|
|
|
|
public virtual bool RunScheduled()
|
|
|
|
|
{
|
|
|
|
|
lock (ExecutionLock)
|
|
|
|
|
{
|
|
|
|
|
if (_isRunning)
|
|
|
|
|
{
|
2011-04-25 06:15:23 +02:00
|
|
|
|
Logger.Info("Another instance of this job is already running. Ignoring request.");
|
2011-04-20 09:44:13 +02:00
|
|
|
|
return false;
|
|
|
|
|
}
|
|
|
|
|
_isRunning = true;
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
try
|
|
|
|
|
{
|
|
|
|
|
var pendingJobs = All().Where(
|
|
|
|
|
t => t.Enable &&
|
|
|
|
|
(DateTime.Now - t.LastExecution) > TimeSpan.FromMinutes(t.Interval)
|
|
|
|
|
);
|
|
|
|
|
|
|
|
|
|
foreach (var pendingTimer in pendingJobs)
|
|
|
|
|
{
|
2011-05-17 09:24:29 +02:00
|
|
|
|
var timer = pendingTimer;
|
|
|
|
|
var timerClass = _jobs.Where(t => t.GetType().ToString() == timer.TypeName).FirstOrDefault();
|
2011-05-17 09:04:49 +02:00
|
|
|
|
Execute(timerClass.GetType());
|
2011-04-20 09:44:13 +02:00
|
|
|
|
}
|
|
|
|
|
}
|
|
|
|
|
finally
|
|
|
|
|
{
|
|
|
|
|
_isRunning = false;
|
|
|
|
|
}
|
|
|
|
|
|
2011-05-17 09:16:45 +02:00
|
|
|
|
Logger.Debug("Finished executing scheduled tasks.");
|
2011-04-20 09:44:13 +02:00
|
|
|
|
return true;
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
/// <summary>
|
|
|
|
|
/// Starts the execution of a job asynchronously
|
|
|
|
|
/// </summary>
|
|
|
|
|
/// <param name="jobType">Type of the job that should be executed.</param>
|
|
|
|
|
/// <param name="targetId">The targetId could be any Id parameter eg. SeriesId. it will be passed to the job implementation
|
|
|
|
|
/// to allow it to filter it's target of execution.</param>
|
|
|
|
|
/// <returns>True if ran, false if skipped</returns>
|
2011-05-17 09:04:49 +02:00
|
|
|
|
/// <remarks>Job is only added to the queue if same job with the same targetId doesn't already exist in the queue.</remarks>
|
|
|
|
|
public virtual bool QueueJob(Type jobType, int targetId = 0)
|
2011-04-20 09:44:13 +02:00
|
|
|
|
{
|
2011-05-17 09:04:49 +02:00
|
|
|
|
Logger.Debug("Adding job {0} ->{1} to the queue", jobType, targetId);
|
|
|
|
|
lock (Queue)
|
|
|
|
|
{
|
|
|
|
|
var queueTuple = new Tuple<Type, int>(jobType, targetId);
|
|
|
|
|
|
|
|
|
|
if (Queue.Contains(queueTuple))
|
|
|
|
|
{
|
|
|
|
|
Logger.Info("Job {0} ->{1} already exists in queue. Skipping.", jobType, targetId);
|
|
|
|
|
return false;
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
Queue.Add(queueTuple);
|
|
|
|
|
Logger.Debug("Job {0} ->{1} added to the queue", jobType, targetId);
|
|
|
|
|
|
|
|
|
|
}
|
|
|
|
|
|
2011-04-20 09:44:13 +02:00
|
|
|
|
lock (ExecutionLock)
|
|
|
|
|
{
|
|
|
|
|
if (_isRunning)
|
|
|
|
|
{
|
2011-05-19 05:59:12 +02:00
|
|
|
|
Logger.Trace("Queue is already running. Ignoring request.");
|
2011-05-17 09:04:49 +02:00
|
|
|
|
return true;
|
2011-04-20 09:44:13 +02:00
|
|
|
|
}
|
2011-05-17 09:04:49 +02:00
|
|
|
|
|
2011-04-20 09:44:13 +02:00
|
|
|
|
}
|
2011-05-17 09:04:49 +02:00
|
|
|
|
|
2011-04-20 09:44:13 +02:00
|
|
|
|
if (_jobThread == null || !_jobThread.IsAlive)
|
|
|
|
|
{
|
2011-05-17 09:04:49 +02:00
|
|
|
|
Logger.Trace("Initializing queue processor thread");
|
2011-04-20 09:44:13 +02:00
|
|
|
|
|
2011-04-21 03:26:13 +02:00
|
|
|
|
ThreadStart starter = () =>
|
|
|
|
|
{
|
|
|
|
|
try
|
|
|
|
|
{
|
2011-05-17 09:04:49 +02:00
|
|
|
|
ProcessQueue();
|
2011-04-21 03:26:13 +02:00
|
|
|
|
}
|
|
|
|
|
finally
|
|
|
|
|
{
|
|
|
|
|
_isRunning = false;
|
|
|
|
|
}
|
|
|
|
|
};
|
|
|
|
|
|
2011-05-17 09:04:49 +02:00
|
|
|
|
_jobThread = new Thread(starter) { Name = "JobQueueThread", Priority = ThreadPriority.BelowNormal };
|
2011-04-20 09:44:13 +02:00
|
|
|
|
_jobThread.Start();
|
|
|
|
|
|
|
|
|
|
}
|
|
|
|
|
else
|
|
|
|
|
{
|
|
|
|
|
Logger.Warn("Thread still active. Ignoring request.");
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
return true;
|
|
|
|
|
}
|
|
|
|
|
|
2011-05-17 09:04:49 +02:00
|
|
|
|
/// <summary>
|
|
|
|
|
/// Starts processing of queue.
|
|
|
|
|
/// </summary>
|
|
|
|
|
private void ProcessQueue()
|
|
|
|
|
{
|
|
|
|
|
Tuple<Type, int> job = null;
|
|
|
|
|
|
|
|
|
|
try
|
|
|
|
|
{
|
|
|
|
|
lock (Queue)
|
|
|
|
|
{
|
|
|
|
|
if (Queue.Count != 0)
|
|
|
|
|
{
|
|
|
|
|
job = Queue[0];
|
|
|
|
|
}
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
if (job != null)
|
|
|
|
|
{
|
|
|
|
|
Execute(job.Item1, job.Item2);
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
}
|
|
|
|
|
catch (Exception e)
|
|
|
|
|
{
|
2011-05-19 05:59:12 +02:00
|
|
|
|
Logger.FatalException("An error has occurred while processing queued job.", e);
|
2011-05-17 09:04:49 +02:00
|
|
|
|
}
|
|
|
|
|
finally
|
|
|
|
|
{
|
|
|
|
|
if (job != null)
|
|
|
|
|
{
|
|
|
|
|
Queue.Remove(job);
|
|
|
|
|
}
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
//Try to find next job is last run found a job.
|
|
|
|
|
if (job != null)
|
|
|
|
|
{
|
|
|
|
|
ProcessQueue();
|
|
|
|
|
}
|
|
|
|
|
else
|
|
|
|
|
{
|
|
|
|
|
Logger.Debug("Finished processing jobs in the queue.");
|
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
return;
|
|
|
|
|
}
|
|
|
|
|
|
2011-04-20 09:44:13 +02:00
|
|
|
|
/// <summary>
|
|
|
|
|
/// Executes the job
|
|
|
|
|
/// </summary>
|
|
|
|
|
/// <param name="jobType">Type of the job that should be executed</param>
|
|
|
|
|
/// <param name="targetId">The targetId could be any Id parameter eg. SeriesId. it will be passed to the timer implementation
|
|
|
|
|
/// to allow it to filter it's target of execution</param>
|
|
|
|
|
private void Execute(Type jobType, int targetId = 0)
|
|
|
|
|
{
|
2011-05-17 09:24:29 +02:00
|
|
|
|
var jobImplementation = _jobs.Where(t => t.GetType() == jobType).FirstOrDefault();
|
|
|
|
|
if (jobImplementation == null)
|
2011-04-20 09:44:13 +02:00
|
|
|
|
{
|
2011-05-13 06:46:26 +02:00
|
|
|
|
Logger.Error("Unable to locate implementation for '{0}'. Make sure its properly registered.", jobType.ToString());
|
2011-04-20 09:44:13 +02:00
|
|
|
|
return;
|
|
|
|
|
}
|
|
|
|
|
|
2011-04-22 07:46:47 +02:00
|
|
|
|
var settings = All().Where(j => j.TypeName == jobType.ToString()).FirstOrDefault();
|
|
|
|
|
|
2011-05-17 09:24:29 +02:00
|
|
|
|
using (_notification = new ProgressNotification(jobImplementation.Name))
|
2011-04-20 09:44:13 +02:00
|
|
|
|
{
|
2011-04-22 08:23:29 +02:00
|
|
|
|
try
|
2011-04-20 09:44:13 +02:00
|
|
|
|
{
|
2011-04-25 05:51:18 +02:00
|
|
|
|
Logger.Debug("Starting job '{0}'. Last execution {1}", settings.Name, settings.LastExecution);
|
2011-05-18 07:29:23 +02:00
|
|
|
|
|
2011-04-22 08:23:29 +02:00
|
|
|
|
var sw = Stopwatch.StartNew();
|
|
|
|
|
|
2011-04-20 09:44:13 +02:00
|
|
|
|
_notificationProvider.Register(_notification);
|
2011-05-17 09:24:29 +02:00
|
|
|
|
jobImplementation.Start(_notification, targetId);
|
2011-04-20 09:44:13 +02:00
|
|
|
|
_notification.Status = ProgressNotificationStatus.Completed;
|
2011-05-17 17:33:32 +02:00
|
|
|
|
|
2011-05-18 07:29:23 +02:00
|
|
|
|
settings.LastExecution = DateTime.Now;
|
|
|
|
|
settings.Success = true;
|
2011-05-17 17:33:32 +02:00
|
|
|
|
|
2011-04-22 08:23:29 +02:00
|
|
|
|
sw.Stop();
|
2011-05-17 09:24:29 +02:00
|
|
|
|
Logger.Debug("Job '{0}' successfully completed in {1} seconds", jobImplementation.Name, sw.Elapsed.Minutes,
|
2011-04-22 08:23:29 +02:00
|
|
|
|
sw.Elapsed.Seconds);
|
|
|
|
|
}
|
|
|
|
|
catch (Exception e)
|
|
|
|
|
{
|
2011-05-18 07:29:23 +02:00
|
|
|
|
settings.LastExecution = DateTime.Now;
|
2011-04-22 08:23:29 +02:00
|
|
|
|
settings.Success = false;
|
2011-05-18 07:29:23 +02:00
|
|
|
|
|
2011-05-17 09:24:29 +02:00
|
|
|
|
Logger.ErrorException("An error has occurred while executing timer job " + jobImplementation.Name, e);
|
|
|
|
|
_notification.CurrentMessage = jobImplementation.Name + " Failed.";
|
2011-04-22 08:23:29 +02:00
|
|
|
|
_notification.Status = ProgressNotificationStatus.Failed;
|
2011-04-20 09:44:13 +02:00
|
|
|
|
}
|
|
|
|
|
}
|
2011-04-22 07:46:47 +02:00
|
|
|
|
|
2011-05-18 07:29:23 +02:00
|
|
|
|
if (targetId == 0)
|
|
|
|
|
{
|
|
|
|
|
SaveSettings(settings);
|
|
|
|
|
}
|
2011-04-20 09:44:13 +02:00
|
|
|
|
}
|
|
|
|
|
|
|
|
|
|
/// <summary>
|
|
|
|
|
/// Initializes jobs in the database using the IJob instances that are
|
|
|
|
|
/// registered in CentralDispatch
|
|
|
|
|
/// </summary>
|
|
|
|
|
public virtual void Initialize()
|
|
|
|
|
{
|
2011-04-25 05:51:18 +02:00
|
|
|
|
Logger.Debug("Initializing jobs. Count {0}", _jobs.Count());
|
2011-04-20 09:44:13 +02:00
|
|
|
|
var currentTimer = All();
|
|
|
|
|
|
|
|
|
|
foreach (var timer in _jobs)
|
|
|
|
|
{
|
|
|
|
|
var timerProviderLocal = timer;
|
|
|
|
|
if (!currentTimer.Exists(c => c.TypeName == timerProviderLocal.GetType().ToString()))
|
|
|
|
|
{
|
2011-04-21 03:26:13 +02:00
|
|
|
|
var settings = new JobSetting
|
2011-04-20 09:44:13 +02:00
|
|
|
|
{
|
2011-05-11 20:25:32 +02:00
|
|
|
|
Enable = timerProviderLocal.DefaultInterval > 0,
|
2011-04-20 09:44:13 +02:00
|
|
|
|
TypeName = timer.GetType().ToString(),
|
|
|
|
|
Name = timerProviderLocal.Name,
|
|
|
|
|
Interval = timerProviderLocal.DefaultInterval,
|
|
|
|
|
LastExecution = DateTime.MinValue
|
|
|
|
|
};
|
|
|
|
|
|
|
|
|
|
SaveSettings(settings);
|
|
|
|
|
}
|
|
|
|
|
}
|
|
|
|
|
}
|
|
|
|
|
|
2011-05-17 06:01:01 +02:00
|
|
|
|
/// <summary>
|
|
|
|
|
/// Gets the next scheduled run time for the job
|
|
|
|
|
/// (Estimated due to schedule timer)
|
|
|
|
|
/// </summary>
|
2011-05-17 09:04:49 +02:00
|
|
|
|
/// <returns>DateTime of next scheduled job execution</returns>
|
2011-05-17 06:01:01 +02:00
|
|
|
|
public virtual DateTime NextScheduledRun(Type jobType)
|
|
|
|
|
{
|
|
|
|
|
var job = All().Where(t => t.TypeName == jobType.ToString()).FirstOrDefault();
|
|
|
|
|
|
|
|
|
|
if (job == null)
|
|
|
|
|
return DateTime.Now;
|
2011-04-20 09:44:13 +02:00
|
|
|
|
|
2011-05-17 06:01:01 +02:00
|
|
|
|
return job.LastExecution.AddMinutes(job.Interval);
|
|
|
|
|
}
|
2011-04-20 09:44:13 +02:00
|
|
|
|
}
|
|
|
|
|
}
|