using System; using System.Collections.Generic; using System.Diagnostics; using System.Linq; using System.Threading; using Ninject; using NLog; using NzbDrone.Core.Model.Notification; using NzbDrone.Core.Repository; using PetaPoco; namespace NzbDrone.Core.Providers.Jobs { public class JobProvider { private static readonly Logger Logger = LogManager.GetCurrentClassLogger(); private readonly IDatabase _database; private readonly NotificationProvider _notificationProvider; private readonly IList _jobs; private static readonly object ExecutionLock = new object(); private Thread _jobThread; private static bool _isRunning; private static readonly List> Queue = new List>(); private ProgressNotification _notification; [Inject] public JobProvider(IDatabase database, NotificationProvider notificationProvider, IList jobs) { _database = database; _notificationProvider = notificationProvider; _jobs = jobs; } public JobProvider() { } /// /// Returns a list of all registered jobs /// /// public virtual List All() { return _database.Fetch().ToList(); } /// /// Creates/Updates settings for a job /// /// Settings to be created/updated public virtual void SaveSettings(JobSetting settings) { if (settings.Id == 0) { Logger.Trace("Adding job settings for {0}", settings.Name); _database.Insert(settings); } else { Logger.Trace("Updating job settings for {0}", settings.Name); _database.Update(settings); } } /// /// Iterates through all registered jobs and executed any that are due for an execution. /// /// True if ran, false if skipped public virtual bool RunScheduled() { lock (ExecutionLock) { if (_isRunning) { Logger.Info("Another instance of this job is already running. Ignoring request."); 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) { var timer = pendingTimer; var timerClass = _jobs.Where(t => t.GetType().ToString() == timer.TypeName).FirstOrDefault(); Execute(timerClass.GetType()); } } finally { _isRunning = false; } Logger.Trace("Finished executing scheduled tasks."); return true; } /// /// Starts the execution of a job asynchronously /// /// Type of the job that should be executed. /// 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. /// True if queued, false if duplicate and was skipped /// Job is only added to the queue if same job with the same targetId doesn't already exist in the queue. public virtual bool QueueJob(Type jobType, int targetId = 0) { Logger.Debug("Adding job ({0}:{1}) to the queue", jobType, targetId); lock (Queue) { var queueTuple = new Tuple(jobType, targetId); if (Queue.Contains(queueTuple)) { Logger.Info("Job ({0}:{1}) already exists in queue. Skipping.", jobType, targetId); return false; } Queue.Add(queueTuple); Logger.Trace("Job ({0}:{1}) added to the queue", jobType, targetId); } lock (ExecutionLock) { if (_isRunning) { Logger.Trace("Queue is already running. Ignoring request."); return true; } _isRunning = true; } if (_jobThread == null || !_jobThread.IsAlive) { Logger.Trace("Initializing queue processor thread"); ThreadStart starter = () => { try { ProcessQueue(); } catch (Exception e) { Logger.ErrorException("Error has occured in queue processor thread", e); } finally { _isRunning = false; } }; _jobThread = new Thread(starter) { Name = "JobQueueThread", Priority = ThreadPriority.BelowNormal }; _jobThread.Start(); } else { Logger.Warn("Execution lock has has fucked up. Thread still active. Ignoring request."); return true; } return true; } /// /// Starts processing of queue. /// private void ProcessQueue() { Tuple job = null; try { lock (Queue) { if (Queue.Count != 0) { job = Queue[0]; } } if (job != null) { Execute(job.Item1, job.Item2); } } catch (Exception e) { Logger.FatalException("An error has occurred while processing queued job.", e); } finally { if (job != null) { Queue.Remove(job); } } //Try to find next job is last run found a job. if (job != null) { ProcessQueue(); } else { Logger.Trace("Finished processing jobs in the queue."); } return; } /// /// Executes the job /// /// Type of the job that should be executed /// 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 private void Execute(Type jobType, int targetId = 0) { var jobImplementation = _jobs.Where(t => t.GetType() == jobType).FirstOrDefault(); if (jobImplementation == null) { Logger.Error("Unable to locate implementation for '{0}'. Make sure its properly registered.", jobType.ToString()); return; } var settings = All().Where(j => j.TypeName == jobType.ToString()).FirstOrDefault(); using (_notification = new ProgressNotification(jobImplementation.Name)) { try { Logger.Debug("Starting job '{0}'. Last execution {1}", settings.Name, settings.LastExecution); var sw = Stopwatch.StartNew(); _notificationProvider.Register(_notification); jobImplementation.Start(_notification, targetId); _notification.Status = ProgressNotificationStatus.Completed; settings.LastExecution = DateTime.Now; settings.Success = true; sw.Stop(); Logger.Debug("Job '{0}' successfully completed in {1} seconds", jobImplementation.Name, sw.Elapsed.Minutes, sw.Elapsed.Seconds); } catch (Exception e) { Logger.ErrorException("An error has occurred while executing timer job " + jobImplementation.Name, e); _notification.Status = ProgressNotificationStatus.Failed; _notification.CurrentMessage = jobImplementation.Name + " Failed."; settings.LastExecution = DateTime.Now; settings.Success = false; } } if (targetId == 0) { SaveSettings(settings); } } /// /// Initializes jobs in the database using the IJob instances that are /// registered in CentralDispatch /// public virtual void Initialize() { Logger.Debug("Initializing jobs. Count {0}", _jobs.Count()); var currentTimer = All(); foreach (var timer in _jobs) { var timerProviderLocal = timer; if (!currentTimer.Exists(c => c.TypeName == timerProviderLocal.GetType().ToString())) { var settings = new JobSetting { Enable = timerProviderLocal.DefaultInterval > 0, TypeName = timer.GetType().ToString(), Name = timerProviderLocal.Name, Interval = timerProviderLocal.DefaultInterval, LastExecution = DateTime.MinValue }; SaveSettings(settings); } } } /// /// Gets the next scheduled run time for the job /// (Estimated due to schedule timer) /// /// DateTime of next scheduled job execution public virtual DateTime NextScheduledRun(Type jobType) { var job = All().Where(t => t.TypeName == jobType.ToString()).FirstOrDefault(); if (job == null) return DateTime.Now; return job.LastExecution.AddMinutes(job.Interval); } } }