recording tv just stopped :( HELP!!! (2 Viewers)

[robbo100]

OK, I have had a reoccurance using the latest debugging TVServer.exe. Please see the attached logs (sorry, I didn't clean out the logs before I started, so they are bigger than they needed to be).

 

[mm1352000]

OK, I have had a reoccurance using the latest debugging TVServer.exe.

Okay - this is good. Looks like the problem is at least occurring in the same place:

[2013-11-16 16:30:07,149] [Log ] [scheduler thread] [INFO ] - debug: check and delete orphaned recordings
[2013-11-16 16:30:07,150] [Log ] [scheduler thread] [INFO ] - debug: got card list

However, I don't understand why/how the thread is being stopped.

Here's the code:

  [MethodImpl(MethodImplOptions.Synchronized)]
  private void DoScheduleWork()
  {
    Log.Write("debug: stop any due recordings");
    StopAnyDueRecordings();
    Log.Write("debug: start any due recordings");
    StartAnyDueRecordings();
    Log.Write("debug: check and delete orphaned recordings");
    CheckAndDeleteOrphanedRecordings();
    Log.Write("debug: check and delete orphaned once schedules");
    CheckAndDeleteOrphanedOnceSchedules();
    Log.Write("debug: handle sleep mode");
    HandleSleepMode();
    Log.Write("debug: work complete");
  }

  private void CheckAndDeleteOrphanedRecordings()
  {
    List<VirtualCard> vCards = _tvController.GetAllRecordingCards();
    Log.Write("debug: got card list");

    foreach (VirtualCard vCard in vCards)
    {
      Log.Write("debug: card {0}", vCard.Name);
      int schedId = vCard.RecordingScheduleId;
      Log.Write("debug: schedule {0}", schedId);
      if (schedId > 0)
      {
        Log.Write("debug: get schedule");
        Schedule sc = Schedule.Retrieve(schedId);
        Log.Write("debug: got schedule");
        if (sc == null)
        {
          //seems like the schedule has disappeared  stop the recording also.
          Log.Debug("Scheduler: Orphaned Recording found {0} - removing", schedId);
          StopRecordingSchedule(schedId);
        }
        Log.Write("debug: done stop");
      }
      Log.Write("debug: done check");
    }
  }

So it is like the thread didn't make it into the foreach loop (we don't see "debug: card...")... but it also didn't return to the main scheduler worker flow (we don't see "debug: check and delete orphaned once schedules"). Bizarre!

Interestingly, your EPG import/update finished at almost exactly the same time, though this seems to be a coincidence as it didn't happen in your previous log files.

Also, in your older logs (I'm glad you included them) we can see that the TV service appears to not stop cleanly. Compare this clean stop:
[collapse][2013-11-16 16:14:40,293] [Log ] [TVService] [INFO ] - TvService is being stopped
[2013-11-16 16:14:40,295] [Log ] [TVService] [INFO ] - TV Service: stopping
[2013-11-16 16:14:40,298] [Log ] [TVService] [INFO ] - TV Service: Stop plugins
[2013-11-16 16:14:40,299] [Log ] [TVService] [DEBUG] - Removing MPExtended powerhandler
[2013-11-16 16:14:40,301] [Log ] [TVService] [INFO ] - PS: Stopping PowerScheduler server plugin...
[2013-11-16 16:14:40,314] [Log ] [TVService] [DEBUG] - PS: UnRegistered IPowerEventHandler from GlobalServiceProvider
[2013-11-16 16:14:40,317] [Log ] [TVService] [DEBUG] - PS: Removed standby/wakeup handlers
[2013-11-16 16:14:40,328] [Log ] [TVService] [INFO ] - PS: PowerScheduler server plugin stopped
[2013-11-16 16:14:40,329] [Log ] [TVService] [INFO ] - plugin: xmltv stopped
[2013-11-16 16:14:40,331] [Log ] [TVService] [DEBUG] - xmltv: UnRegistered xmltv as PowerEventHandler to tvservice
[2013-11-16 16:14:40,332] [Log ] [TVService] [INFO ] - TV Service: Plugins stopped
[2013-11-16 16:14:40,333] [Log ] [TVService] [INFO ] - TV service StopRemoting
[2013-11-16 16:14:40,334] [Log ] [TVService] [INFO ] - Remoting stopped
[2013-11-16 16:14:40,335] [Log ] [TVService] [INFO ] - Controller: DeInit.
[2013-11-16 16:14:40,336] [Log ] [TVService] [INFO ] - Controller: HeartBeat monitor stopped...
[2013-11-16 16:14:40,347] [Log ] [TVService] [INFO ] - Controller: stop streamer...
[2013-11-16 16:14:40,348] [Log ] [TVService] [INFO ] - RTSP: stop streamer
[2013-11-16 16:14:40,349] [Log ] [TVService] [INFO ] - RTSP: stop all streams (0)
[2013-11-16 16:14:40,350] [Log ] [TVService] [INFO ] - Controller: streamer stopped...
[2013-11-16 16:14:40,351] [Log ] [TVService] [INFO ] - Controller: stop thumb processor...
[2013-11-16 16:14:40,352] [Log ] [TVService] [INFO ] - ThumbProcessor.Stop()
[2013-11-16 16:14:40,353] [Log ] [TVService] [INFO ] - Controller: thumb processor stopped...
[2013-11-16 16:14:40,354] [Log ] [TVService] [INFO ] - Controller: stop scheduler...
[2013-11-16 16:14:40,355] [Log ] [TVService] [INFO ] - Scheduler: stopped
[2013-11-16 16:14:40,356] [Log ] [scheduler thread] [INFO ] - debug: stop any due recordings
[2013-11-16 16:14:40,356] [Log ] [scheduler thread] [INFO ] - debug: start any due recordings
[2013-11-16 16:14:40,362] [Log ] [scheduler thread] [INFO ] - debug: check and delete orphaned recordings
[2013-11-16 16:14:40,362] [Log ] [scheduler thread] [INFO ] - debug: check and delete orphaned once schedules
[2013-11-16 16:14:40,364] [Log ] [scheduler thread] [INFO ] - debug: handle sleep mode
[2013-11-16 16:14:40,364] [Log ] [scheduler thread] [INFO ] - debug: work complete
[2013-11-16 16:14:40,364] [Log ] [scheduler thread] [INFO ] - debug: scheduler worker loop reset event
[2013-11-16 16:14:40,365] [Log ] [scheduler thread] [INFO ] - debug: scheduler worker loop end
[2013-11-16 16:14:40,365] [Log ] [scheduler thread] [INFO ] - debug: scheduler worker exit
[2013-11-16 16:14:40,366] [Log ] [TVService] [DEBUG] - Scheduler: thread stopped.
[2013-11-16 16:14:40,380] [Log ] [TVService] [INFO ] - Controller: scheduler stopped...
[2013-11-16 16:14:40,382] [Log ] [TVService] [INFO ] - Controller: epg stop
[2013-11-16 16:14:40,383] [Log ] [TVService] [INFO ] - Controller: dispose card:RadioWebStream Card (builtin)
[2013-11-16 16:14:40,385] [Log ] [TVService] [INFO ] - RadioWebStreamispose()
[2013-11-16 16:14:40,386] [Log ] [TVService] [INFO ] - Controller: dispose card:MediaPortal IPTV Source Filter
[2013-11-16 16:14:40,387] [Log ] [TVService] [INFO ] - Controller: dispose card:WinTV HVR-900H TVTuner
[2013-11-16 16:14:40,389] [Log ] [TVService] [INFO ] - Controller: dispose card:TBS 6982 DVBS/S2 Tuner A
[2013-11-16 16:14:40,390] [Log ] [TVService] [INFO ] - dvbecompose
[2013-11-16 16:14:40,392] [Log ] [TVService] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-16 16:14:40,394] [Log ] [TVService] [INFO ] - stop
[2013-11-16 16:14:40,496] [Log ] [TVService] [INFO ] - Disposing ConditionalAccess
[2013-11-16 16:14:40,497] [Log ] [TVService] [INFO ] - free...
[2013-11-16 16:14:40,498] [Log ] [TVService] [INFO ] - free pins...
[2013-11-16 16:14:40,500] [Log ] [TVService] [INFO ] - free graph...
[2013-11-16 16:14:40,501] [Log ] [TVService] [INFO ] - Remove filter from graph: BDA MPEG2 Transport Information Filter
[2013-11-16 16:14:40,503] [Log ] [TVService] [INFO ] - Remove filter from graph: MediaPortal Ts Analyzer
[2013-11-16 16:14:40,504] [Log ] [TVService] [INFO ] - Remove filter from graph: MPEG2-Demultiplexer
[2013-11-16 16:14:40,506] [Log ] [TVService] [INFO ] - Remove filter from graph: Inf Tee
[2013-11-16 16:14:40,508] [Log ] [TVService] [INFO ] - Remove filter from graph: TBS 6982 BDA Digital Capture A DVBS
[2013-11-16 16:14:40,511] [Log ] [TVService] [INFO ] - Remove filter from graph: TBS 6982 DVBS/S2 Tuner A
[2013-11-16 16:14:40,513] [Log ] [TVService] [INFO ] - Remove filter from graph: Generic Network Provider
[2013-11-16 16:14:40,515] [Log ] [TVService] [INFO ] - free devices...
[2013-11-16 16:14:40,517] [Log ] [TVService] [INFO ] - decompose done...
[2013-11-16 16:14:40,519] [Log ] [TVService] [INFO ] - Controller: dispose card:TBS 6982 DVBS/S2 Tuner B
[2013-11-16 16:14:40,520] [Log ] [TVService] [INFO ] - dvbecompose
[2013-11-16 16:14:40,521] [Log ] [TVService] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-16 16:14:40,522] [Log ] [TVService] [INFO ] - stop
[2013-11-16 16:14:40,625] [Log ] [TVService] [INFO ] - Disposing ConditionalAccess
[2013-11-16 16:14:40,626] [Log ] [TVService] [INFO ] - free...
[2013-11-16 16:14:40,627] [Log ] [TVService] [INFO ] - free pins...
[2013-11-16 16:14:40,629] [Log ] [TVService] [INFO ] - free graph...
[2013-11-16 16:14:40,631] [Log ] [TVService] [INFO ] - Remove filter from graph: BDA MPEG2 Transport Information Filter
[2013-11-16 16:14:40,632] [Log ] [TVService] [INFO ] - Remove filter from graph: MediaPortal Ts Analyzer
[2013-11-16 16:14:40,634] [Log ] [TVService] [INFO ] - Remove filter from graph: MPEG2-Demultiplexer
[2013-11-16 16:14:40,635] [Log ] [TVService] [INFO ] - Remove filter from graph: Inf Tee
[2013-11-16 16:14:40,637] [Log ] [TVService] [INFO ] - Remove filter from graph: TBS 6982 BDA Digital Capture B DVBS
[2013-11-16 16:14:40,639] [Log ] [TVService] [INFO ] - Remove filter from graph: TBS 6982 DVBS/S2 Tuner B
[2013-11-16 16:14:40,641] [Log ] [TVService] [INFO ] - Remove filter from graph: Generic Network Provider
[2013-11-16 16:14:40,644] [Log ] [TVService] [INFO ] - free devices...
[2013-11-16 16:14:40,646] [Log ] [TVService] [INFO ] - decompose done...
[2013-11-16 16:14:40,648] [Log ] [TVService] [INFO ] - Controller: dispose card:WinTV HVR-900H BDA Tuner
[2013-11-16 16:14:40,649] [Log ] [TVService] [INFO ] - Stopping async device detection...
[2013-11-16 16:14:40,653] [Log ] [TVService] [INFO ] - Stopping async device detection...
[2013-11-16 16:14:40,654] [Log ] [TVService] [INFO ] - RadioWebStreamispose()
[2013-11-16 16:14:40,656] [Log ] [TVService] [INFO ] - Remove filter from graph: DVB-T Network Provider
[2013-11-16 16:14:40,657] [Log ] [TVService] [INFO ] - Remove filter from graph: DVB-S Network Provider
[2013-11-16 16:14:40,659] [Log ] [TVService] [INFO ] - Remove filter from graph: DVB-C Network Provider
[2013-11-16 16:14:40,660] [Log ] [TVService] [INFO ] - Remove filter from graph: ATSC Network Provider
[2013-11-16 16:14:40,662] [Log ] [TVService] [DEBUG] - TV Service: OnStop asking PowerEventThread to exit
[2013-11-16 16:14:40,664] [Log ] [PowerEventThread] [DEBUG] - TV service PowerEventThread finished
[2013-11-16 16:14:40,664] [Log ] [TVService] [INFO ] - TV Service: stopped[/collapse]

...with...
[collapse]
[2013-11-16 09:52:41,715] [Log ] [TVService] [INFO ] - TvService is being stopped
[2013-11-16 09:52:41,718] [Log ] [TVService] [INFO ] - TV Service: stopping
[2013-11-16 09:52:41,719] [Log ] [TVService] [INFO ] - TV Service: Stop plugins
[2013-11-16 09:52:41,721] [Log ] [TVService] [DEBUG] - Removing MPExtended powerhandler
[2013-11-16 09:52:41,722] [Log ] [TVService] [INFO ] - PS: Stopping PowerScheduler server plugin...
[2013-11-16 09:52:41,733] [Log ] [TVService] [DEBUG] - PS: UnRegistered IPowerEventHandler from GlobalServiceProvider
[2013-11-16 09:52:41,735] [Log ] [TVService] [DEBUG] - PS: Removed standby/wakeup handlers
[2013-11-16 09:52:41,746] [Log ] [TVService] [INFO ] - PS: PowerScheduler server plugin stopped
[2013-11-16 09:52:41,747] [Log ] [TVService] [INFO ] - plugin: xmltv stopped
[2013-11-16 09:52:41,748] [Log ] [TVService] [DEBUG] - xmltv: UnRegistered xmltv as PowerEventHandler to tvservice
[2013-11-16 09:52:41,749] [Log ] [TVService] [INFO ] - TV Service: Plugins stopped
[2013-11-16 09:52:41,751] [Log ] [TVService] [INFO ] - TV service StopRemoting
[2013-11-16 09:52:41,752] [Log ] [TVService] [INFO ] - Remoting stopped
[2013-11-16 09:52:41,753] [Log ] [TVService] [INFO ] - Controller: DeInit.
[2013-11-16 09:52:41,754] [Log ] [TVService] [INFO ] - Controller: HeartBeat monitor stopped...
[2013-11-16 09:52:41,765] [Log ] [TVService] [INFO ] - Controller: stop streamer...
[2013-11-16 09:52:41,766] [Log ] [TVService] [INFO ] - RTSP: stop streamer
[2013-11-16 09:52:41,768] [Log ] [TVService] [INFO ] - RTSP: stop all streams (0)
[2013-11-16 09:52:41,769] [Log ] [TVService] [INFO ] - Controller: streamer stopped...
[2013-11-16 09:52:41,770] [Log ] [TVService] [INFO ] - Controller: stop thumb processor...
[2013-11-16 09:52:41,771] [Log ] [TVService] [INFO ] - ThumbProcessor.Stop()
[2013-11-16 09:52:41,772] [Log ] [TVService] [INFO ] - Controller: thumb processor stopped...
[2013-11-16 09:52:41,773] [Log ] [TVService] [INFO ] - Controller: stop scheduler...
[2013-11-16 09:52:41,774] [Log ] [TVService] [INFO ] - Scheduler: stopped[/collapse]

So it looks like tuners are not disposed; stalled at the scheduler stop phase.

Sorry mm, I have been out all day.

Right, I have inserted the new TV Service, and will try to recreate.

Cheers[DOUBLEPOST=1384619084][/DOUBLEPOST]

Are you able to check your MySQL log files and see if there is anything in there. Either slow queries or errors...

Sorry mm - How do I do this?

You can do it via MySQL Workbench. Go into the "server administration" section; on the left hand side is the "server logs section".

 

[robbo100]

Here you go (I had a corrupt database a while back, which I fixed, so I have taken the logs from around that date.

Timestamp, Thread, Type, Details
2013-10-31 19:00:46, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:01:01, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:01:16, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:01:31, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:01:46, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:02:01, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:02:16, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:02:31, , [ERROR], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Table '.\mptvdb\program' is marked as crashed and should be repaired
2013-10-31 19:02:46, , [Note], Found 24630 of 25855 rows when repairing '.\mptvdb\program'
2013-10-31 19:27:51, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-10-31 19:27:51, , [Note], Event Scheduler: Purging the queue. 0 events
2013-10-31 19:27:53, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 52 user: 'root'
2013-10-31 19:27:53, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 50 user: 'root'
2013-10-31 19:27:53, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 49 user: 'root'
2013-10-31 19:27:53, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 30 user: 'root'
2013-10-31 19:27:53, , InnoDB:, Starting shutdown...
2013-10-31 19:27:54, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-10-31 19:27:54, , [Warning], Forcing shutdown of 1 plugins
2013-10-31 19:27:54, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-10-31 19:28:28, , [Note], Plugin 'FEDERATED' is disabled.
2013-10-31 19:28:28, , InnoDB:, Started; log sequence number 0 44233
2013-10-31 19:28:28, , [Note], Event Scheduler: Loaded 0 events
2013-10-31 19:28:28, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-02 8:47:30, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-02 8:47:30, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-02 8:47:32, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 25 user: 'root'
2013-11-02 8:47:32, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 24 user: 'root'
2013-11-02 8:47:32, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 23 user: 'root'
2013-11-02 8:47:32, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 3 user: 'root'
2013-11-02 8:47:32, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-02 8:47:32, , InnoDB:, Starting shutdown...
2013-11-02 8:47:33, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-02 8:47:33, , [Warning], Forcing shutdown of 1 plugins
2013-11-02 8:47:33, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-02 8:48:13, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-02 8:48:14, , InnoDB:, Started; log sequence number 0 44233
2013-11-02 8:48:14, , [Note], Event Scheduler: Loaded 0 events
2013-11-02 8:48:14, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-02 23:52:21, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-02 23:52:21, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-02 23:52:23, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 26 user: 'root'
2013-11-02 23:52:23, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 10 user: 'root'
2013-11-02 23:52:23, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 9 user: 'root'
2013-11-02 23:52:23, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 3 user: 'root'
2013-11-02 23:52:23, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-02 23:52:23, , InnoDB:, Starting shutdown...
2013-11-02 23:52:25, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-02 23:52:25, , [Warning], Forcing shutdown of 1 plugins
2013-11-02 23:52:25, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-02 23:53:07, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-02 23:53:09, , InnoDB:, Started; log sequence number 0 44233
2013-11-02 23:53:09, , [Note], Event Scheduler: Loaded 0 events
2013-11-02 23:53:09, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-05 7:19:22, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-05 7:19:22, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-05 7:19:24, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 26 user: 'root'
2013-11-05 7:19:24, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 25 user: 'root'
2013-11-05 7:19:24, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 24 user: 'root'
2013-11-05 7:19:24, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 23 user: 'root'
2013-11-05 7:19:24, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 22 user: 'root'
2013-11-05 7:19:24, , InnoDB:, Starting shutdown...
2013-11-05 7:19:25, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-05 7:19:25, , [Warning], Forcing shutdown of 1 plugins
2013-11-05 7:19:25, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-05 7:20:17, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-05 7:20:18, , InnoDB:, Started; log sequence number 0 44233
2013-11-05 7:20:18, , [Note], Event Scheduler: Loaded 0 events
2013-11-05 7:20:18, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-05 7:26:27, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-05 7:26:27, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-05 7:26:29, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 3 user: 'root'
2013-11-05 7:26:29, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-05 7:26:29, , InnoDB:, Starting shutdown...
2013-11-05 7:26:30, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-05 7:26:30, , [Warning], Forcing shutdown of 1 plugins
2013-11-05 7:26:30, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-05 7:27:07, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-05 7:27:07, , InnoDB:, Started; log sequence number 0 44233
2013-11-05 7:27:07, , [Note], Event Scheduler: Loaded 0 events
2013-11-05 7:27:07, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-05 7:46:35, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-05 7:46:35, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-05 7:46:37, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-05 7:46:37, , InnoDB:, Starting shutdown...
2013-11-05 7:46:37, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-05 7:46:37, , [Warning], Forcing shutdown of 1 plugins
2013-11-05 7:46:37, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-05 7:47:14, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-05 7:47:14, , InnoDB:, Started; log sequence number 0 44233
2013-11-05 7:47:15, , [Note], Event Scheduler: Loaded 0 events
2013-11-05 7:47:15, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-07 7:23:13, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-07 7:23:13, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-07 7:23:15, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 24 user: 'root'
2013-11-07 7:23:15, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 14 user: 'root'
2013-11-07 7:23:15, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 10 user: 'root'
2013-11-07 7:23:15, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 7 user: 'root'
2013-11-07 7:23:15, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-07 7:23:15, , InnoDB:, Starting shutdown...
2013-11-07 7:23:16, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-07 7:23:16, , [Warning], Forcing shutdown of 1 plugins
2013-11-07 7:23:16, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-07 7:23:56, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-07 7:23:57, , InnoDB:, Started; log sequence number 0 44233
2013-11-07 7:23:57, , [Note], Event Scheduler: Loaded 0 events
2013-11-07 7:23:57, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-08 6:13:01, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-08 6:13:01, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-08 6:13:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 7 user: 'root'
2013-11-08 6:13:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 6 user: 'root'
2013-11-08 6:13:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 2 user: 'root'
2013-11-08 6:13:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-08 6:13:03, , InnoDB:, Starting shutdown...
2013-11-08 6:13:04, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-08 6:13:04, , [Warning], Forcing shutdown of 1 plugins
2013-11-08 6:13:04, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-08 6:13:42, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-08 6:13:43, , InnoDB:, Started; log sequence number 0 44233
2013-11-08 6:13:43, , [Note], Event Scheduler: Loaded 0 events
2013-11-08 6:13:43, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-08 19:45:01, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-08 19:45:01, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-08 19:45:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 10 user: 'root'
2013-11-08 19:45:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 6 user: 'root'
2013-11-08 19:45:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 5 user: 'root'
2013-11-08 19:45:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 3 user: 'root'
2013-11-08 19:45:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-08 19:45:03, , InnoDB:, Starting shutdown...
2013-11-08 19:45:03, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-08 19:45:03, , [Warning], Forcing shutdown of 1 plugins
2013-11-08 19:45:03, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-08 19:45:56, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-08 19:45:56, , InnoDB:, Started; log sequence number 0 44233
2013-11-08 19:45:56, , [Note], Event Scheduler: Loaded 0 events
2013-11-08 19:45:56, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-13 21:06:46, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-13 21:06:46, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-13 21:06:48, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 45 user: 'root'
2013-11-13 21:06:48, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 44 user: 'root'
2013-11-13 21:06:48, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 32 user: 'root'
2013-11-13 21:06:48, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 13 user: 'root'
2013-11-13 21:06:48, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 8 user: 'root'
2013-11-13 21:06:48, , InnoDB:, Starting shutdown...
2013-11-13 21:06:49, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-13 21:06:49, , [Warning], Forcing shutdown of 1 plugins
2013-11-13 21:06:49, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-13 21:07:25, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-13 21:07:25, , InnoDB:, Started; log sequence number 0 44233
2013-11-13 21:07:26, , [Note], Event Scheduler: Loaded 0 events
2013-11-13 21:07:26, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-14 22:13:52, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-14 22:13:52, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-14 22:13:54, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 18 user: 'root'
2013-11-14 22:13:54, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 17 user: 'root'
2013-11-14 22:13:54, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 10 user: 'root'
2013-11-14 22:13:54, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 9 user: 'root'
2013-11-14 22:13:54, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 4 user: 'root'
2013-11-14 22:13:54, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-14 22:13:54, , InnoDB:, Starting shutdown...
2013-11-14 22:13:55, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-14 22:13:55, , [Warning], Forcing shutdown of 1 plugins
2013-11-14 22:13:55, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-14 22:14:38, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-14 22:14:38, , InnoDB:, Started; log sequence number 0 44233
2013-11-14 22:14:38, , [Note], Event Scheduler: Loaded 0 events
2013-11-14 22:14:38, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-15 7:08:47, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-15 7:08:47, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-15 7:08:49, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 3 user: 'root'
2013-11-15 7:08:49, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-15 7:08:49, , InnoDB:, Starting shutdown...
2013-11-15 7:08:50, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-15 7:08:50, , [Warning], Forcing shutdown of 1 plugins
2013-11-15 7:08:50, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-15 7:09:40, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-15 7:09:41, , InnoDB:, Started; log sequence number 0 44233
2013-11-15 7:09:41, , [Note], Event Scheduler: Loaded 0 events
2013-11-15 7:09:41, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-15 22:45:09, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-15 22:45:09, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-15 22:45:11, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 38 user: 'root'
2013-11-15 22:45:11, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 7 user: 'root'
2013-11-15 22:45:11, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 6 user: 'root'
2013-11-15 22:45:11, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 5 user: 'root'
2013-11-15 22:45:11, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 3 user: 'root'
2013-11-15 22:45:11, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-15 22:45:11, , InnoDB:, Starting shutdown...
2013-11-15 22:45:12, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-15 22:45:12, , [Warning], Forcing shutdown of 1 plugins
2013-11-15 22:45:12, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-15 22:45:56, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-15 22:45:56, , InnoDB:, Started; log sequence number 0 44233
2013-11-15 22:45:56, , [Note], Event Scheduler: Loaded 0 events
2013-11-15 22:45:56, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-16 8:26:24, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-16 8:26:24, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-16 8:26:26, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 16 user: 'root'
2013-11-16 8:26:26, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 15 user: 'root'
2013-11-16 8:26:26, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 11 user: 'root'
2013-11-16 8:26:26, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 10 user: 'root'
2013-11-16 8:26:26, , InnoDB:, Starting shutdown...
2013-11-16 8:26:27, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-16 8:26:27, , [Warning], Forcing shutdown of 1 plugins
2013-11-16 8:26:27, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-16 8:27:07, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-16 8:27:08, , InnoDB:, Started; log sequence number 0 44233
2013-11-16 8:27:08, , [Note], Event Scheduler: Loaded 0 events
2013-11-16 8:27:08, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-16 9:53:02, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-16 9:53:03, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-16 9:53:05, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 5 user: 'root'
2013-11-16 9:53:05, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 2 user: 'root'
2013-11-16 9:53:05, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-16 9:53:05, , InnoDB:, Starting shutdown...
2013-11-16 9:53:06, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-16 9:53:06, , [Warning], Forcing shutdown of 1 plugins
2013-11-16 9:53:06, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-16 9:53:57, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-16 9:53:57, , InnoDB:, Started; log sequence number 0 44233
2013-11-16 9:53:57, , [Note], Event Scheduler: Loaded 0 events
2013-11-16 9:53:57, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)
2013-11-16 16:15:01, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Normal shutdown
2013-11-16 16:15:01, , [Note], Event Scheduler: Purging the queue. 0 events
2013-11-16 16:15:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 8 user: 'root'
2013-11-16 16:15:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 7 user: 'root'
2013-11-16 16:15:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 6 user: 'root'
2013-11-16 16:15:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 3 user: 'root'
2013-11-16 16:15:03, , [Warning], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Forcing close of thread 1 user: 'root'
2013-11-16 16:15:03, , InnoDB:, Starting shutdown...
2013-11-16 16:15:04, , InnoDB:, Shutdown completed; log sequence number 0 44233
2013-11-16 16:15:04, , [Warning], Forcing shutdown of 1 plugins
2013-11-16 16:15:04, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: Shutdown complete
2013-11-16 16:15:43, , [Note], Plugin 'FEDERATED' is disabled.
2013-11-16 16:15:43, , InnoDB:, Started; log sequence number 0 44233
2013-11-16 16:15:44, , [Note], Event Scheduler: Loaded 0 events
2013-11-16 16:15:44, , [Note], C:\Program Files\MySQL\MySQL Server 5.1\bin\mysqld.exe: ready for connections.
, , , Version: '5.1.38-community' socket: '' port: 3306 MySQL Community Server (GPL)

So then, if there is no problem with the code, what should my next steps be?...

 

[mm1352000]

Here you go (I had a corrupt database a while back, which I fixed, so I have taken the logs from around that date.

Hmmm, no smoking guns there.

So then, if there is no problem with the code, what should my next steps be?...

That is a very good question and I don't know if I can give you any answers. I have absolutely no idea what is going on here.
@Developers
Any suggestions for further debugging this problem?

 

[robbo100]

Although this problem seemed to be intermittent before, it seems to happen with every recording now.

Very odd.

 

[FreakyJ]

It happened here also 3 times in the last 1 1/2 years. So I don't have logs on my hands right now, just wanted to mention that it is maybe more common than somebody might think.
The Server here is running on Win 7 x64.

I know this is not helping in any way and I'm very sorry about that fact, but as I wrote above, I just wanted to mention it

 

[robbo100]

It happened here also 3 times in the last 1 1/2 years. So I don't have logs on my hands right now, just wanted to mention that it is maybe more common than somebody might think.
The Server here is running on Win 7 x64.

I know this is not helping in any way and I'm very sorry about that fact, but as I wrote above, I just wanted to mention it

No probs.

Maybe a reinstall of OS to win 8 rather than 8.1 might be worth doing. I might wait and see if the update to 1.6 helps (not that it would for any logical reason, but I am grasping at straws).

 

[mm1352000]

Those of you using TBS tuners on W8/8.1: please update your drivers with the latest drivers which have just been released... just on the off chance that it helps.

 

[robbo100]

Those of you using TBS tuners on W8/8.1: please update your drivers with the latest drivers which have just been released... just on the off chance that it helps.

The driver for my card (6982), is still showing on their website as the same version that I am currently using. I will check again in a few days to see if they update it with the others.

 

[mm1352000]

@lewiskingy appears to have the same problem over here:
https://forum.team-mediaportal.com/...ed-recording-doesnt-stop.121872/#post-1038314

I now recognise the problem in logs by looking at the service stopping. If you see this:

[2013-11-11 19:14:25,696] [Log ] [TVService] [INFO ] - Controller: stop scheduler...
[2013-11-11 19:14:25,699] [Log ] [TVService] [INFO ] - Scheduler: stopped

...and don't see this:

[2013-11-12 00:10:04,189] [Log ] [TVService] [DEBUG] - Scheduler: thread stopped.
[2013-11-12 00:10:04,205] [Log ] [TVService] [INFO ] - Controller: scheduler stopped...

...then you have the problem that we've identified in this thread.
lewiskingy's workaround is to run the service under a different user account.

On that note: can you folks please check if the "allow service to interact with desktop" option is ticked on the log on tab? If it is ticked, please try unticking it.

mm