ArgusTVScheduler service crashing on resume from sleep

In the unlikely ;) event you encounter a bug, tell us here
Luca Brasi
Posts: 88
Joined: Sat Jun 26, 2010 10:07 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by Luca Brasi » Thu Feb 13, 2014 5:41 pm

Here are some more of the the errors I get in the event log

Code: Select all

System.ServiceModel.EndpointNotFoundException: Es konnte keine Verbindung mit "net.tcp://localhost:49842/RecorderTunerService" hergestellt werden. Der Verbindungsversuch hat für einen Zeitraum von 00:00:02.0050544 angedauert. TCP-Fehlercode 10061: Es konnte keine Verbindung hergestellt werden, da der Zielcomputer die Verbindung verweigerte 127.0.0.1:49842.  ---> System.Net.Sockets.SocketException: Es konnte keine Verbindung hergestellt werden, da der Zielcomputer die Verbindung verweigerte 127.0.0.1:49842
   bei System.Net.Sockets.Socket.DoConnect(EndPoint endPointSnapshot, SocketAddress socketAddress)
   bei System.Net.Sockets.Socket.Connect(EndPoint remoteEP)
   bei System.ServiceModel.Channels.SocketConnectionInitiator.Connect(Uri uri, TimeSpan timeout)
   --- Ende der internen Ausnahmestapelüberwachung ---

Server stack trace: 
   bei System.ServiceModel.Channels.SocketConnectionInitiator.Connect(Uri uri, TimeSpan timeout)
   bei System.ServiceModel.Channels.BufferedConnectionInitiator.Connect(Uri uri, TimeSpan timeout)
   bei System.ServiceModel.Channels.ConnectionPoolHelper.EstablishConnection(TimeSpan timeout)
   bei System.ServiceModel.Channels.ClientFramingDuplexSessionChannel.OnOpen(TimeSpan timeout)
   bei System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannel.OnOpen(TimeSpan timeout)
   bei System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannel.CallOnceManager.CallOnce(TimeSpan timeout, CallOnceManager cascade)
   bei System.ServiceModel.Channels.ServiceChannel.EnsureOpened(TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannel.Call(String action, Boolean oneway, ProxyOperationRuntime operation, Object[] ins, Object[] outs, TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannelProxy.InvokeService(IMethodCallMessage methodCall, ProxyOperationRuntime operation)
   bei System.ServiceModel.Channels.ServiceChannelProxy.Invoke(IMessage message)

Exception rethrown at [0]: 
   bei ArgusTV.Aspects.ServiceAgentMethod.HandleServiceException(IServiceAgentBase serviceAgent, Exception ex, Boolean& retry)
   bei ArgusTV.Aspects.ServiceAgentMethod.OnInvoke(MethodInterceptionArgs eventArgs)
   bei ArgusTV.Business.ServiceAgents.RecorderTunerServiceAgent.GetChannelsLiveState(Channel[] channels, LiveStream liveStream)
   bei  .(List`1 , LiveStream )
   bei   .(List`1 , Boolean , LiveStream )
   bei ArgusTV.Business.SchedulerFacade.GetCurrentAndNextForGroup(Guid channelGroupId, Boolean visibleOnly, Boolean includeLiveState, LiveStream liveStream)
   bei ArgusTV.ServiceImplementation.SchedulerService.GetCurrentAndNextForGroup(Guid channelGroupId, Boolean visibleOnly, Boolean includeLiveState, LiveStream liveStream)

Code: Select all

System.ServiceModel.CommunicationException: Die Socketverbindung wurde abgebrochen. Dies kann durch einen Fehler beim Verarbeiten der Nachricht, durch ein Überschreiten des Empfangstimeouts durch den Remotehost oder durch eine Problem bei der zugrundeliegenden Netzwerkressource verursacht sein. Lokaler Sockettimeout: "00:01:00". ---> System.Net.Sockets.SocketException: Eine vorhandene Verbindung wurde vom Remotehost geschlossen
   bei System.Net.Sockets.Socket.Receive(Byte[] buffer, Int32 offset, Int32 size, SocketFlags socketFlags)
   bei System.ServiceModel.Channels.SocketConnection.ReadCore(Byte[] buffer, Int32 offset, Int32 size, TimeSpan timeout, Boolean closing)
   --- Ende der internen Ausnahmestapelüberwachung ---

Server stack trace: 
   bei System.ServiceModel.Channels.SocketConnection.ReadCore(Byte[] buffer, Int32 offset, Int32 size, TimeSpan timeout, Boolean closing)
   bei System.ServiceModel.Channels.SocketConnection.Read(Byte[] buffer, Int32 offset, Int32 size, TimeSpan timeout)
   bei System.ServiceModel.Channels.ClientFramingDuplexSessionChannel.SendPreamble(IConnection connection, ArraySegment`1 preamble, TimeoutHelper& timeoutHelper)
   bei System.ServiceModel.Channels.ClientFramingDuplexSessionChannel.DuplexConnectionPoolHelper.AcceptPooledConnection(IConnection connection, TimeoutHelper& timeoutHelper)
   bei System.ServiceModel.Channels.ConnectionPoolHelper.EstablishConnection(TimeSpan timeout)
   bei System.ServiceModel.Channels.ClientFramingDuplexSessionChannel.OnOpen(TimeSpan timeout)
   bei System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannel.OnOpen(TimeSpan timeout)
   bei System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannel.CallOnceManager.CallOnce(TimeSpan timeout, CallOnceManager cascade)
   bei System.ServiceModel.Channels.ServiceChannel.EnsureOpened(TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannel.Call(String action, Boolean oneway, ProxyOperationRuntime operation, Object[] ins, Object[] outs, TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannelProxy.InvokeService(IMethodCallMessage methodCall, ProxyOperationRuntime operation)
   bei System.ServiceModel.Channels.ServiceChannelProxy.Invoke(IMessage message)

Exception rethrown at [0]: 
   bei ArgusTV.Aspects.ServiceAgentMethod.HandleServiceException(IServiceAgentBase serviceAgent, Exception ex, Boolean& retry)
   bei ArgusTV.Aspects.ServiceAgentMethod.OnInvoke(MethodInterceptionArgs eventArgs)
   bei ArgusTV.Business.ServiceAgents.RecorderTunerServiceAgent.GetRecordingShares()
   bei  .()
   bei  .()
   bei ArgusTV.ServiceImplementation.ControlService.GetRecordingDisksInfo()

Code: Select all

NHibernate.Exceptions.GenericADOException: could not execute query
[ select distinct TOP (@p0)  guideprogr0_.GuideProgramId as GuidePro1_1_, guideprogr0_.Version as Version1_, guideprogr0_.Id as Id1_, guideprogr0_.GuideChannelId as GuideCha4_1_, guideprogr0_.Title as Title1_, guideprogr0_.StartTime as StartTime1_, guideprogr0_.StopTime as StopTime1_, guideprogr0_.StartTimeUtc as StartTim8_1_, guideprogr0_.StopTimeUtc as StopTime9_1_, guideprogr0_.SubTitle as SubTitle1_, guideprogr0_.Description as Descrip11_1_, guideprogr0_.Category as Category1_, guideprogr0_.IsRepeat as IsRepeat1_, guideprogr0_.IsPremiere as IsPremiere1_, guideprogr0_.VideoAspect as VideoAs15_1_, guideprogr0_.SeriesNumber as SeriesN16_1_, guideprogr0_.EpisodeNumberDisplay as Episode17_1_, guideprogr0_.EpisodeNumber as Episode18_1_, guideprogr0_.EpisodeNumberTotal as Episode19_1_, guideprogr0_.EpisodePart as Episode20_1_, guideprogr0_.EpisodePartTotal as Episode21_1_, guideprogr0_.Rating as Rating1_, guideprogr0_.StarRating as StarRating1_, guideprogr0_.Source as Source1_, guideprogr0_.PreviouslyAiredTime as Previou25_1_, guideprogr0_.SeriesId as SeriesId1_, guideprogr0_.IsSeriesTermination as IsSerie27_1_, guideprogr0_.LastModifiedTime as LastMod28_1_, guideprogr0_.IsDeleted as IsDeleted1_ from GuideProgram guideprogr0_ inner join GuideProgramWordFragment wordfragme1_ on guideprogr0_.Id=wordfragme1_.GuideProgramIntId inner join WordFragment wordfragme2_ on wordfragme1_.WordFragmentId=wordfragme2_.WordFragmentId where guideprogr0_.IsDeleted=0 and (wordfragme2_.Fragment like @p1 or wordfragme2_.Fragment like @p2) and (guideprogr0_.Title like @p3 or guideprogr0_.Title like @p4) and (guideprogr0_.Title is null or guideprogr0_.Title not like @p5) and (guideprogr0_.Title is null or guideprogr0_.Title not like @p6) and (3600*datepart(hour, guideprogr0_.StartTime)+60*datepart(minute, guideprogr0_.StartTime)+datepart(second, guideprogr0_.StartTime)>=@p7 or 3600*datepart(hour, guideprogr0_.StartTime)+60*datepart(minute, guideprogr0_.StartTime)+datepart(second, guideprogr0_.StartTime)<=@p8) and (guideprogr0_.GuideChannelId in (@p9 , @p10)) and guideprogr0_.StopTimeUtc>=@p11 order by guideprogr0_.StartTimeUtc ]
  Name:p7 - Value:57600  Name:p8 - Value:7140  Name:p1 - Value:heute%  Name:p2 - Value:tagest%  Name:p3 - Value:%heute%  Name:p4 - Value:%tagesthemen%  Name:p5 - Value:%Show%  Name:p6 - Value:%Leute%  Name:p10 - Value:08.02.2014 04:39:16  Name:p9_0_ - Value:b76a01e5-adcc-44e3-8d64-af6cd60c4373  Name:p9_1_ - Value:ac95159d-3496-483c-b86b-d170247de76b
[SQL: select distinct TOP (@p0)  guideprogr0_.GuideProgramId as GuidePro1_1_, guideprogr0_.Version as Version1_, guideprogr0_.Id as Id1_, guideprogr0_.GuideChannelId as GuideCha4_1_, guideprogr0_.Title as Title1_, guideprogr0_.StartTime as StartTime1_, guideprogr0_.StopTime as StopTime1_, guideprogr0_.StartTimeUtc as StartTim8_1_, guideprogr0_.StopTimeUtc as StopTime9_1_, guideprogr0_.SubTitle as SubTitle1_, guideprogr0_.Description as Descrip11_1_, guideprogr0_.Category as Category1_, guideprogr0_.IsRepeat as IsRepeat1_, guideprogr0_.IsPremiere as IsPremiere1_, guideprogr0_.VideoAspect as VideoAs15_1_, guideprogr0_.SeriesNumber as SeriesN16_1_, guideprogr0_.EpisodeNumberDisplay as Episode17_1_, guideprogr0_.EpisodeNumber as Episode18_1_, guideprogr0_.EpisodeNumberTotal as Episode19_1_, guideprogr0_.EpisodePart as Episode20_1_, guideprogr0_.EpisodePartTotal as Episode21_1_, guideprogr0_.Rating as Rating1_, guideprogr0_.StarRating as StarRating1_, guideprogr0_.Source as Source1_, guideprogr0_.PreviouslyAiredTime as Previou25_1_, guideprogr0_.SeriesId as SeriesId1_, guideprogr0_.IsSeriesTermination as IsSerie27_1_, guideprogr0_.LastModifiedTime as LastMod28_1_, guideprogr0_.IsDeleted as IsDeleted1_ from GuideProgram guideprogr0_ inner join GuideProgramWordFragment wordfragme1_ on guideprogr0_.Id=wordfragme1_.GuideProgramIntId inner join WordFragment wordfragme2_ on wordfragme1_.WordFragmentId=wordfragme2_.WordFragmentId where guideprogr0_.IsDeleted=0 and (wordfragme2_.Fragment like @p1 or wordfragme2_.Fragment like @p2) and (guideprogr0_.Title like @p3 or guideprogr0_.Title like @p4) and (guideprogr0_.Title is null or guideprogr0_.Title not like @p5) and (guideprogr0_.Title is null or guideprogr0_.Title not like @p6) and (3600*datepart(hour, guideprogr0_.StartTime)+60*datepart(minute, guideprogr0_.StartTime)+datepart(second, guideprogr0_.StartTime)>=@p7 or 3600*datepart(hour, guideprogr0_.StartTime)+60*datepart(minute, guideprogr0_.StartTime)+datepart(second, guideprogr0_.StartTime)<=@p8) and (guideprogr0_.GuideChannelId in (@p9 , @p10)) and guideprogr0_.StopTimeUtc>=@p11 order by guideprogr0_.StartTimeUtc] ---> System.Data.SqlClient.SqlException: Die Transaktion (Prozess-ID 51) befand sich auf Sperre Ressourcen aufgrund eines anderen Prozesses in einer Deadlocksituation und wurde als Deadlockopfer ausgewählt. Führen Sie die Transaktion erneut aus.
   bei System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection, Action`1 wrapCloseInAction)
   bei System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj, Boolean callerHasConnectionLock, Boolean asyncClose)
   bei System.Data.SqlClient.TdsParser.TryRun(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj, Boolean& dataReady)
   bei System.Data.SqlClient.SqlDataReader.TryHasMoreRows(Boolean& moreRows)
   bei System.Data.SqlClient.SqlDataReader.TryReadInternal(Boolean setTimeout, Boolean& more)
   bei System.Data.SqlClient.SqlDataReader.Read()
   bei NHibernate.Driver.NHybridDataReader.Read()
   bei NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Boolean returnProxies)
   bei NHibernate.Loader.Loader.DoQueryAndInitializeNonLazyCollections(ISessionImplementor session, QueryParameters queryParameters, Boolean returnProxies)
   bei NHibernate.Loader.Loader.DoList(ISessionImplementor session, QueryParameters queryParameters)
   --- Ende der internen Ausnahmestapelüberwachung ---
   bei NHibernate.Loader.Loader.DoList(ISessionImplementor session, QueryParameters queryParameters)
   bei NHibernate.Loader.Loader.ListIgnoreQueryCache(ISessionImplementor session, QueryParameters queryParameters)
   bei NHibernate.Hql.Ast.ANTLR.Loader.QueryLoader.List(ISessionImplementor session, QueryParameters queryParameters)
   bei NHibernate.Hql.Ast.ANTLR.QueryTranslatorImpl.List(ISessionImplementor session, QueryParameters queryParameters)
   bei NHibernate.Engine.Query.HQLQueryPlan.PerformList(QueryParameters queryParameters, ISessionImplementor session, IList results)
   bei NHibernate.Impl.SessionImpl.List(String query, QueryParameters queryParameters, IList results)
   bei NHibernate.Impl.SessionImpl.List[T](String query, QueryParameters parameters)
   bei NHibernate.Impl.QueryImpl.List[T]()
   bei   .(Schedule , Boolean )
   bei   .(Schedule , Boolean , Boolean )
   bei   ..()
   bei ArgusTV.Business.Cache.UpcomingCache.GetUpcomingPrograms(Guid scheduleId, String md5, Func`1 getPrograms)
   bei   .(ScheduleType )
   bei ArgusTV.Business.Cache.UpcomingCache.(ISessionContext , ScheduleType , Nullable`1 , Boolean , Boolean , Boolean )
   bei ArgusTV.Business.Cache.UpcomingCache.(ISessionContext , ScheduleType , Nullable`1 , Boolean , Boolean )
   bei ArgusTV.Business.Cache.UpcomingCache.GetAllUpcomingPrograms(ISessionContext context, ScheduleType type, Boolean includeCancelled, Boolean cancelAlreadyQueuedRecordings)
   bei  .(Boolean& )
   bei ArgusTV.Business.Cache.UpcomingCache.(UpcomingRecordingsFilter , Boolean , Boolean )
   bei ArgusTV.Business.Cache.UpcomingCache.GetNextUpcomingRecording(Boolean includeActive)
   bei ArgusTV.ServiceImplementation.ControlService.GetNextUpcomingRecording(Boolean includeActive)

Code: Select all

System.ServiceModel.FaultException: Der Server konnte die Anforderung aufgrund eines internen Fehlers nicht verarbeiten. Wenn Sie weitere Informationen zum Fehler erhalten möchten, aktivieren Sie entweder IncludeExceptionDetailInFaults (über das ServiceBehaviorAttribute oder das <serviceDebug>-Konfigurationsverhalten) für den Client, um die Ausnahmeinformationen zurück an den Server zu senden, oder aktivieren Sie die Ablaufverfolgung gemäß der Microsoft .NET Framework SDK-Dokumentation, und überprüfen Sie die Serverablaufverfolgungsprotokolle.

Server stack trace: 
   bei System.ServiceModel.Channels.ServiceChannel.ThrowIfFaultUnderstood(Message reply, MessageFault fault, String action, MessageVersion version, FaultConverter faultConverter)
   bei System.ServiceModel.Channels.ServiceChannel.HandleReply(ProxyOperationRuntime operation, ProxyRpc& rpc)
   bei System.ServiceModel.Channels.ServiceChannel.Call(String action, Boolean oneway, ProxyOperationRuntime operation, Object[] ins, Object[] outs, TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannelProxy.InvokeService(IMethodCallMessage methodCall, ProxyOperationRuntime operation)
   bei System.ServiceModel.Channels.ServiceChannelProxy.Invoke(IMessage message)

Exception rethrown at [0]: 
   bei ArgusTV.Aspects.ServiceAgentMethod.HandleServiceException(IServiceAgentBase serviceAgent, Exception ex, Boolean& retry)
   bei ArgusTV.Aspects.ServiceAgentMethod.OnInvoke(MethodInterceptionArgs eventArgs)
   bei ArgusTV.Business.ServiceAgents.RecorderTunerServiceAgent.GetRecordingShares()
   bei  .()
   bei ArgusTV.ServiceImplementation.ControlService.GetRecordingShares()

Code: Select all

System.TimeoutException: Dieser an net.tcp://localhost:49842/RecorderTunerService gesendete Anforderungsvorgang hat innerhalb des konfigurierten Zeitlimits (00:01:00) keine Antwort empfangen. Der für diesen Vorgang zugewiesene Zeitraum war möglicherweise ein Teil eines längeren Timeouts. Mögliche Ursachen: Der Dienst verarbeitet den Vorgang noch, oder der Dienst konnte keine Antwortnachricht senden. Erwägen Sie, das Zeitlimit für den Vorgang zu erhöhen (indem Sie den Kanal/Proxy in IContextChannel umwandeln und die OperationTimeout-Eigenschaft festlegen), und stellen Sie sicher, dass der Dienst eine Verbindung mit dem Client herstellen kann.

Server stack trace: 
   bei System.ServiceModel.Dispatcher.DuplexChannelBinder.Request(Message message, TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannel.Call(String action, Boolean oneway, ProxyOperationRuntime operation, Object[] ins, Object[] outs, TimeSpan timeout)
   bei System.ServiceModel.Channels.ServiceChannelProxy.InvokeService(IMethodCallMessage methodCall, ProxyOperationRuntime operation)
   bei System.ServiceModel.Channels.ServiceChannelProxy.Invoke(IMessage message)

Exception rethrown at [0]: 
   bei ArgusTV.Aspects.ServiceAgentMethod.HandleServiceException(IServiceAgentBase serviceAgent, Exception ex, Boolean& retry)
   bei ArgusTV.Aspects.ServiceAgentMethod.OnInvoke(MethodInterceptionArgs eventArgs)
   bei ArgusTV.Business.ServiceAgents.RecorderTunerServiceAgent.GetChannelsLiveState(Channel[] channels, LiveStream liveStream)
   bei  .(List`1 , LiveStream )
   bei   .(List`1 , Boolean , LiveStream )
   bei ArgusTV.Business.SchedulerFacade.GetCurrentAndNextForGroup(Guid channelGroupId, Boolean visibleOnly, Boolean includeLiveState, LiveStream liveStream)
   bei ArgusTV.ServiceImplementation.SchedulerService.GetCurrentAndNextForGroup(Guid channelGroupId, Boolean visibleOnly, Boolean includeLiveState, LiveStream liveStream)
HTPC: Win8.1Pro, Argus TV latest, MediaPortal 1.7, 1xFireDTV DVB-C, 2x Mystique Cabix DVB-C, 2xDigital Devices Cine Dvb-C

Luca Brasi
Posts: 88
Joined: Sat Jun 26, 2010 10:07 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by Luca Brasi » Fri Feb 14, 2014 3:36 pm

Argus just crashed in the middle of watching tv. Means it worked after hibernate but just stopped. The service froze and again only a reboot solved it.
I had no errors from those above in the event log. Only errors around the time of failure are these:

Code: Select all

- <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
- <System>
  <Provider Name="Microsoft-Windows-Perflib" Guid="{13B197BD-7CEE-4B4E-8DD0-59314CE374CE}" EventSourceName="Perflib" /> 
  <EventID Qualifiers="49152">1008</EventID> 
  <Version>0</Version> 
  <Level>2</Level> 
  <Task>0</Task> 
  <Opcode>0</Opcode> 
  <Keywords>0x80000000000000</Keywords> 
  <TimeCreated SystemTime="2014-02-14T13:15:51.000000000Z" /> 
  <EventRecordID>70559</EventRecordID> 
  <Correlation /> 
  <Execution ProcessID="0" ThreadID="0" /> 
  <Channel>Application</Channel> 
  <Computer>mmhtpc</Computer> 
  <Security /> 
  </System>
- <UserData>
- <EventXML xmlns="Perflib">
  <param1>BITS</param1> 
  <param2>C:\Windows\System32\bitsperf.dll</param2> 
  <binaryDataSize>8</binaryDataSize> 
  <binaryData>0200000000000000</binaryData> 
  </EventXML>
  </UserData>
  </Event>

Code: Select all

- <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
- <System>
  <Provider Name="Microsoft-Windows-Perflib" Guid="{13B197BD-7CEE-4B4E-8DD0-59314CE374CE}" EventSourceName="Perflib" /> 
  <EventID Qualifiers="49152">1023</EventID> 
  <Version>0</Version> 
  <Level>2</Level> 
  <Task>0</Task> 
  <Opcode>0</Opcode> 
  <Keywords>0x80000000000000</Keywords> 
  <TimeCreated SystemTime="2014-02-14T13:15:51.000000000Z" /> 
  <EventRecordID>70560</EventRecordID> 
  <Correlation /> 
  <Execution ProcessID="0" ThreadID="0" /> 
  <Channel>Application</Channel> 
  <Computer>mmhtpc</Computer> 
  <Security /> 
  </System>
- <UserData>
- <EventXML xmlns="Perflib">
  <param1>MSSQLSERVER</param1> 
  <binaryDataSize>8</binaryDataSize> 
  <binaryData>7E00000000000000</binaryData> 
  </EventXML>
  </UserData>
  </Event>

Code: Select all

- <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
- <System>
  <Provider Name="Microsoft-Windows-Perflib" Guid="{13B197BD-7CEE-4B4E-8DD0-59314CE374CE}" EventSourceName="Perflib" /> 
  <EventID Qualifiers="49152">1023</EventID> 
  <Version>0</Version> 
  <Level>2</Level> 
  <Task>0</Task> 
  <Opcode>0</Opcode> 
  <Keywords>0x80000000000000</Keywords> 
  <TimeCreated SystemTime="2014-02-14T13:15:52.000000000Z" /> 
  <EventRecordID>70562</EventRecordID> 
  <Correlation /> 
  <Execution ProcessID="0" ThreadID="0" /> 
  <Channel>Application</Channel> 
  <Computer>mmhtpc</Computer> 
  <Security /> 
  </System>
- <UserData>
- <EventXML xmlns="Perflib">
  <param1>SQLSERVERAGENT</param1> 
  <binaryDataSize>8</binaryDataSize> 
  <binaryData>7E00000000000000</binaryData> 
  </EventXML>
  </UserData>
  </Event>
Those are coming from Performance Library but one is regarding SQLSERVERAGENT. Maybe there's the rub...
HTPC: Win8.1Pro, Argus TV latest, MediaPortal 1.7, 1xFireDTV DVB-C, 2x Mystique Cabix DVB-C, 2xDigital Devices Cine Dvb-C

Christoph21x
Posts: 1070
Joined: Wed Oct 19, 2011 9:39 am
Location: Berne / Switzerland

Re: ArgusTVScheduler service crashing on resume from sleep

Post by Christoph21x » Sat Feb 15, 2014 1:23 pm

jeffski10 wrote:I've had this issue for ages on Win7 and see exactly the same thing - if I wake the machine manually it may stop running but is fine if the timer wakes it although occasionally that is not true. In the end I have set up a task to run on resume to check if the service has stopped a couple of minutes after restart and then reboot if so. Seemed the only belt and braces way round missing recordings.

There are a few other posts on the subject.
Dear Jeff, thanks for this interesting approach - could you give me a bit of a "how-and-what-to-do" to do the same thing here?
Thanks in advance - Chris
"One must still have chaos within oneself, to give birth to a dancing star." (F. Nietzsche)

jeffski10
Posts: 92
Joined: Sat Feb 28, 2009 2:03 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by jeffski10 » Sat Feb 15, 2014 5:46 pm

Sure,

Create a batch file that conatins

Code: Select all

sc query ArgusTVScheduler| find /I "STOPPED">nul && shutdown /r
Then create a windows task to run it 2 minutes after event:
Log: System
Source: Power-Troubleshooter
Event ID 1

This give Argus a bit of time to try and start then reboots if that fails.

Server: Windows 7, Argus recorder, Silicon Dust tuners
Clients: Openelec on a Pi and Gigabyte Brix

SQLDBA
Posts: 37
Joined: Tue Aug 27, 2013 4:55 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by SQLDBA » Tue Feb 18, 2014 5:39 pm

Looks like version 2.2.2 (viewtopic.php?f=67&t=4845) was released on Monday. No mention of changes specific to service crashes in the notes, but perhaps there's a hidden surprise in there. I've installed it already and am testing sleep out now.

btb82
Posts: 59
Joined: Sun Feb 05, 2012 2:44 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by btb82 » Wed Feb 19, 2014 10:27 am

I don't know if this will help you, maybe worth trying as a workaround. I sometimes had an issue when the scheduler crashed on waking, not very often but enough to look for a solution, so I run this script in a bat file on resume...

Code: Select all

TIMEOUT /T 5
taskkill /f /t /im ArgusTV.Scheduler.exe >nul 2>nul
TIMEOUT /T 5
net start "ArgusTVScheduler"
It waits 5 seconds after waking then kills the scheduler task, waits again then starts it. I found I had to kill the task first, because just trying to restert the service ended up not working.

The issue I had with the scheduler was a long time ago now, and it may have been down to a problem on my pc, but I keep running the bat file on resume just in case, and it can't do any harm to give the scheduler a clean start after waking.

SQLDBA
Posts: 37
Joined: Tue Aug 27, 2013 4:55 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by SQLDBA » Wed Feb 19, 2014 4:44 pm

Almost 24 hours later and at least 10 times resuming from sleep both manually and from scheduled recordings, and not a single case of the service crashing! 2.2.2 is looking good so far. :-D

SQLDBA
Posts: 37
Joined: Tue Aug 27, 2013 4:55 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by SQLDBA » Fri Feb 21, 2014 5:34 pm

Had my first failure on manual wake from sleep this morning. Unlike the previous failures under 2.2.1, I can actually restart the service without issue.

I've written a PowerShell script to restart failed Argus services and am testing having it hooked up to a scheduled task that's triggered by a wake from sleep. Will post here when I confirm it's working.

ChrisRichner
Posts: 42
Joined: Tue Dec 25, 2012 11:16 am
Location: Lucerne, Switzerland
Contact:

Re: ArgusTVScheduler service crashing on resume from sleep

Post by ChrisRichner » Sat Feb 22, 2014 9:40 am

Hi

I'm facing exactly the same issue described in the first post. My event log entries do look exactly the same.

I've already faced this issue back in January 2013 and solved it by a combination of scheduled task to start the service on a interval basis and by installing the latest argus versions.

But since Version 2.2.2 I'm facing the issue again and in a severe manner. My event log is full with those two entries.

I'm using a one seat installation with SQL-Server, Windows 8.1 x64 with no general problems waking up from hibernate

This problem is really annoying and it seems that the issue was never really solved in the service code.

Thanks for bringing some insight to this problem

Suggestion :idea:
I've tried to set the recovery actions in the service mmc properties dialog page, Tab Recorvery as followed

Code: Select all

First failure: Restart the Service
Second failure: Restart the Service
Subsequent failures: Restart the Computer 
this had no impact because the service itself did not fail on service-start.

The service must fail on start if it faces an internal exception to allow the service controller to run the recovery actions.

Is there any important reason the service code is not written this way :?:

SQLDBA
Posts: 37
Joined: Tue Aug 27, 2013 4:55 pm

Re: ArgusTVScheduler service crashing on resume from sleep

Post by SQLDBA » Mon Feb 24, 2014 11:38 pm

I had high hopes for 2.2.2 but it looks like I'm back to random scheduler service crashes on manual resume from sleep. Happened once Saturday morning and again this morning, and in both cases trying to restart the service (multiple times) failed and forced a reboot to clear the issue.

Here's today's failure from the Scheduler log, starting with a clean shutdown at 3:30 AM after a scheduled task to run comskip completed, failing on manual resume, and failing to start via PowerShell Restart-Service cmdlet:

Code: Select all

2014-02-24 03:32:18,903 [DEBUG][1]: Calling OnPowerEvent(Suspend)...
2014-02-24 03:32:18,903 [INFO ][1]: System entering suspend state, shutting down core services.
2014-02-24 03:32:19,028 [INFO ][ARGUS TV]: Stopping service.
2014-02-24 03:32:19,044 [INFO ][ThumbnailCreator]: ThumbnailCreator thread ended.
2014-02-24 03:32:19,044 [INFO ][Update Check]: Update Check thread ended.
2014-02-24 03:32:19,044 [INFO ][EventSource]: EventSource thread ended.
2014-02-24 03:32:19,044 [INFO ][PostProcessing]: PostProcessing thread ended.
2014-02-24 03:32:19,044 [INFO ][LiveStreamAlive]: LiveStreamAlive thread ended.
2014-02-24 03:32:19,044 [INFO ][Mailer]: Mailer thread ended.
2014-02-24 03:32:19,044 [INFO ][Recordings Cleanup]: Recordings Cleanup thread ended.
2014-02-24 03:32:19,044 [INFO ][Recordings Scheduler]: Recordings Scheduler thread ended.
2014-02-24 03:32:19,044 [INFO ][XMLTV Import]: XMLTV Import thread ended.
2014-02-24 03:32:19,137 [INFO ][ARGUS TV]: Service ended.
2014-02-24 03:32:19,137 [INFO ][ARGUS TV]: ARGUS TV thread ended.
2014-02-24 03:32:19,137 [DEBUG][1]: System can now enter suspend state, core services have shut down.
2014-02-24 14:59:22,777 [DEBUG][1]: Calling OnPowerEvent(ResumeSuspend)...
2014-02-24 14:59:22,777 [INFO ][1]: System resumed from suspend state, restarting core services.
2014-02-24 14:59:22,777 [INFO ][ARGUS TV]: ARGUS TV version 2.2.2 main-thread started.
2014-02-24 14:59:22,777 [INFO ][ARGUS TV]: Starting service.
2014-02-24 14:59:22,777 [INFO ][ARGUS TV]: Ensuring database is up.
2014-02-24 14:59:30,560 [DEBUG][1]: Calling OnPowerEvent(ResumeAutomatic)...
2014-02-24 14:59:31,294 [INFO ][ARGUS TV]: Initializing configuration defaults.
2014-02-24 14:59:31,356 [INFO ][ARGUS TV]: Starting WCF service hosts.
2014-02-24 14:59:46,395 [ERROR][ARGUS TV]: System.ServiceModel.AddressAlreadyInUseException: There is already a listener on IP endpoint 0.0.0.0:49942. This could happen if there is another application already listening on this endpoint or if you have multiple service endpoints in your service host with the same IP endpoint but with incompatible binding configurations. ---> System.Net.Sockets.SocketException: Only one usage of each socket address (protocol/network address/port) is normally permitted
   at System.Net.Sockets.Socket.DoBind(EndPoint endPointSnapshot, SocketAddress socketAddress)
   at System.Net.Sockets.Socket.Bind(EndPoint localEP)
   at System.ServiceModel.Channels.SocketConnectionListener.Listen()
   --- End of inner exception stack trace ---
   at System.ServiceModel.Channels.SocketConnectionListener.Listen()
   at System.ServiceModel.Channels.ConnectionAcceptor.StartAccepting()
   at System.ServiceModel.Channels.ExclusiveTcpTransportManager.OnOpen()
   at System.ServiceModel.Channels.TransportManager.Open(TransportChannelListener channelListener)
   at System.ServiceModel.Channels.TransportManagerContainer.Open(SelectTransportManagersCallback selectTransportManagerCallback)
   at System.ServiceModel.Channels.TcpChannelListener`2.OnOpen(TimeSpan timeout)
   at System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   at System.ServiceModel.Dispatcher.ChannelDispatcher.OnOpen(TimeSpan timeout)
   at System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   at System.ServiceModel.ServiceHostBase.OnOpen(TimeSpan timeout)
   at System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   at ArgusTV.Scheduler.MainThread.OpenNewServiceHost(Type serviceType, Type interfaceType)
   at ArgusTV.Scheduler.MainThread.BootupArgusTV()
   at ArgusTV.Scheduler.MainThread.Run()
2014-02-24 14:59:46,831 [INFO ][ARGUS TV]: Stopping service.
2014-02-24 14:59:46,831 [ERROR][ARGUS TV]: System.NullReferenceException: Object reference not set to an instance of an object.
   at ArgusTV.Scheduler.MainThread.ShutdownArgusTV()
   at ArgusTV.Scheduler.MainThread.Run()
2014-02-24 14:59:46,831 [INFO ][ARGUS TV]: ARGUS TV thread ended.
2014-02-24 15:05:08,971 [INFO ][1]: Computer name: VANDYKE-HTPC, manufacturer: Gigabyte Technology Co., Ltd., model: To be filled by O.E.M.
2014-02-24 15:05:09,096 [INFO ][1]:   OS: Microsoft Windows 8 Pro - 64-bit
2014-02-24 15:05:10,705 [INFO ][1]:   CPU: Intel(R) Core(TM) i3-3220T CPU @ 2.80GHz
2014-02-24 15:05:10,780 [DEBUG][1]:   Video controller: Intel(R) HD Graphics
2014-02-24 15:05:10,805 [DEBUG][1]:    Driver version: 10.18.10.3379, date: 20131218000000.000000-000
2014-02-24 15:05:10,817 [DEBUG][1]:    Video mode: 1280 x 720 x 4294967296 colors
2014-02-24 15:05:10,859 [INFO ][ARGUS TV]: ARGUS TV version 2.2.2 main-thread started.
2014-02-24 15:05:10,859 [INFO ][ARGUS TV]: Starting service.
2014-02-24 15:05:11,031 [INFO ][ARGUS TV]: Ensuring database is up.
2014-02-24 15:05:15,407 [INFO ][ARGUS TV]: Initializing configuration defaults.
2014-02-24 15:05:15,450 [INFO ][ARGUS TV]: Starting WCF service hosts.
2014-02-24 15:05:28,203 [ERROR][ARGUS TV]: System.ServiceModel.AddressAlreadyInUseException: There is already a listener on IP endpoint 0.0.0.0:49942. This could happen if there is another application already listening on this endpoint or if you have multiple service endpoints in your service host with the same IP endpoint but with incompatible binding configurations. ---> System.Net.Sockets.SocketException: Only one usage of each socket address (protocol/network address/port) is normally permitted
   at System.Net.Sockets.Socket.DoBind(EndPoint endPointSnapshot, SocketAddress socketAddress)
   at System.Net.Sockets.Socket.Bind(EndPoint localEP)
   at System.ServiceModel.Channels.SocketConnectionListener.Listen()
   --- End of inner exception stack trace ---
   at System.ServiceModel.Channels.SocketConnectionListener.Listen()
   at System.ServiceModel.Channels.ConnectionAcceptor.StartAccepting()
   at System.ServiceModel.Channels.ExclusiveTcpTransportManager.OnOpen()
   at System.ServiceModel.Channels.TransportManager.Open(TransportChannelListener channelListener)
   at System.ServiceModel.Channels.TransportManagerContainer.Open(SelectTransportManagersCallback selectTransportManagerCallback)
   at System.ServiceModel.Channels.TcpChannelListener`2.OnOpen(TimeSpan timeout)
   at System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   at System.ServiceModel.Dispatcher.ChannelDispatcher.OnOpen(TimeSpan timeout)
   at System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   at System.ServiceModel.ServiceHostBase.OnOpen(TimeSpan timeout)
   at System.ServiceModel.Channels.CommunicationObject.Open(TimeSpan timeout)
   at ArgusTV.Scheduler.MainThread.OpenNewServiceHost(Type serviceType, Type interfaceType)
   at ArgusTV.Scheduler.MainThread.BootupArgusTV()
   at ArgusTV.Scheduler.MainThread.Run()
2014-02-24 15:05:28,415 [INFO ][ARGUS TV]: Stopping service.
Starting to think I may try to reproduce this in a Virtual Machine...

Post Reply

Who is online

Users browsing this forum: No registered users and 11 guests