MP2 - V2.1 TV Service has malfunctions (1 Viewer)

[Fafnir]

There seems to be an occasional problem with the TV Service.

Since yesterday I faced the following problem:
After resuming from hibernation the TV Service seems to be running, but does not work correctly.
Trying to launch the TV Service Configuration lead to the screen below.

Trying to reproduce the error by sending the system to hibernation and then resume does not lead to a recurrence.
In the services view the TV Service is showed as running.

• After manual restart of the service it runs normally.
• After complete restart of the computer it runs normally.

It seems that the "crash" happens after a certain idle time.

Regards, Fafnir

 

[HTPCSourcer]

Hello Fafnir,

thank you for the logs, much appreciated. Unfortunately they are taken in INFO mode only and show little information. Please refer to the Wiki here for details how to increase the logging level.

The screenshot shows an error message, which means that the server has refused the connection from the client. The problem occurred at 05:09, but there is no respective server log:

Server.log starts at 05.10:07
Server.1.log ends at 05:07:24​

Please adjust log level as explained and repost logs when the problem happens again.

 

[dhrto]

I have a similar problem (I think). After a being idle for a while, the MP2-server service shuts down for no reason (service stopped running, when checking in windows with services.msc). See attached logs. The "crash" happened somewhere between just after midnight and before 10:40 this morning.

 

[HTPCSourcer]

I have a similar problem (I think).

We'll see. Similar symptoms don't necessarily mean same reason.

As for Fafnir your Logs are taken at INFO level and don't contain sufficient information. Please refer to what I wrote above for setting the log level to ALL.

After a being idle for a while, the MP2-server service shuts down for no reason (service stopped running, when checking in windows with services.msc).

I don't see this in the log, As you can see events are logged until 23:56 - I assume that server PC is then entering standby - and then resumes at 06:41 without a service start in between.

Spoiler: Spoiler

[2017-01-04 23:56:41,364] [54236 ] [DVB EPG timer] [INFO ] - Controller: GrabEpg on card ID == 5
[2017-01-05 00:06:41,503] [654374 ] [64 ] [INFO ] - Controller: AbortEPGGrabbing on card ID == 5
[2017-01-05 00:06:43,372] [656243 ] [64 ] [INFO ] - Timeshifting epg grabber stopped.
[2017-01-05 00:07:24,470] [697341 ] [EPG Update thread] [INFO ] - schedule.SynchProgramStatesForAll

Logging continues until 08:11:

[2017-01-05 08:11:18,330] [29731202] [120      ] [INFO ] - Media item 4ea60687-54d7-4d0b-8a11-96cc71b83734 with name Eddie Morra (4ea60687-54d7-4d0b-8a11-96cc71b83734) added/updated (1 ms)

This is the last entry, so if anything happened, it was at or after this time. Please check your Windows event log for any critical events after 08:10.

I need logs at ALL level to further investigate.

 

[dhrto]

@HTPCSourcer what do you mean by "ALL level". Debug level seems the most comprehensive one I can select in the TV-server config?

This entry from \MP2-Server\ServerError.1.log looks suspicious to me:
[2017-01-04 23:56:02,771] [15643 ] [DVB EPG timer] [ERROR] -
System.Runtime.Remoting.RemotingException: Requested Service not found

Server stack trace:
at System.Runtime.Remoting.Channels.BinaryServerFormatterSink.ProcessMessage(IServerChannelSinkStack sinkStack, IMessage requestMsg, ITransportHeaders requestHeaders, Stream requestStream, IMessage& responseMsg, ITransportHeaders& responseHeaders, Stream& responseStream)

Exception rethrown at [0]:
at System.Runtime.Remoting.Proxies.RealProxy.HandleReturnMessage(IMessage reqMsg, IMessage retMsg)
at System.Runtime.Remoting.Proxies.RealProxy.PrivateInvoke(MessageData& msgData, Int32 type)
at TvControl.IController.IsRecording(IUser& user)
at TvService.EpgCard.IsCardIdle(Int32 cardId)
at TvService.EpgCard.GrabEpgForChannel(Channel channel, IChannel tuning, Card card)
at TvService.EpgCard.GrabEpg()
at TvService.EpgGrabber.GrabEpgOnCard(EpgCard epgCard)
at TvService.EpgGrabber._epgTimer_Elapsed(Object sender, ElapsedEventArgs e)

The service does not crash however, because later this entry is found:
[2017-01-05 08:11:02,366] [29715237] [120 ] [ERROR] - MediaLibrary: Error downloading FanArt for media item 852112ae-b274-42d0-86dc-867f8a82fa3c
System.ArgumentException: An item with the same key has already been added.
at System.ThrowHelper.ThrowArgumentException(ExceptionResource resource)
at System.Collections.Generic.Dictionary`2.Insert(TKey key, TValue value, Boolean add)
at System.Collections.Generic.Dictionary`2.Add(TKey key, TValue value)
at MediaPortal.Extensions.MetadataExtractors.MovieMetadataExtractor.MovieFanArtHandler.CollectFanArt(Guid mediaItemId, IDictionary`2 aspects)
at MediaPortal.Backend.Services.MediaLibrary.MediaLibrary.CollectFanArt(Guid mediaItemId, IDictionary`2 aspects)

So the crash happened somewhere between 8:11 and 10:40 (when I manually restarted the service).

 

[dhrto]

After some more digging in the eventviewer, seems MediaInfo is the culprit? 2 entries are found, see below.
Also found similar entries from the days before.

Edited for better readibility (HTPCSourcer)

Spoiler: First

First
Log Name: Application
Source: .NET Runtime
Date: 5-1-2017 08:11:11
Event ID: 1026
Task Category: None
Level: Error
Keywords: Classic
User: N/A
Computer: tvserver4.pexis.dnsalias.org
Description:
Application: MP2-Server.exe
Framework Version: v4.0.30319
Description: The process was terminated due to an unhandled exception.
Exception Info: System.AccessViolationException
at MediaInfoLib.MediaInfo.MediaInfpen(IntPtr, System.String)
at MediaInfoLib.MediaInfpen(System.String)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.ReadMediaInfo(MediaPortal.Common.ResourceAccess.IFileSystemResourceAccessor)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.TryExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1<MediaPortal.Common.MediaManagement.IMetadataExtractor>, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1<System.Guid>, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.ImporterWorkerDataflowBlockBase.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+<ProcessMediaItem>d__3.MoveNext()
at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].Start[[MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+<ProcessMediaItem>d__3, MediaPortal.Common, Version=2.1.1612.9730, Culture=neutral, PublicKeyToken=null]](<ProcessMediaItem>d__3 ByRef)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock.ProcessMediaItem(MediaPortal.Common.Services.MediaManagement.PendingImportResourceNewGen)
at System.Threading.Tasks.Dataflow.TransformBlock`2[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessageWithTask(System.Func`2<System.__Canon,System.Threading.Tasks.Task`1<System.__Canon>>, System.Collections.Generic.KeyValuePair`2<System.__Canon,Int64>)
at System.Threading.Tasks.Dataflow.TransformBlock`2+<>c__DisplayClass10[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].<.ctor>b__4(System.Collections.Generic.KeyValuePair`2<System.__Canon,Int64>)
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessagesLoopCore()
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].<ProcessAsyncIfNecessary_Slow>b__3(System.Object)
at System.Threading.Tasks.Task.InnerInvoke()
at System.Threading.Tasks.Task.Execute()
at System.Threading.Tasks.Task.ExecutionContextCallback(System.Object)
at System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.Tasks.Task.ExecuteWithThreadLocal(System.Threading.Tasks.Task ByRef)
at System.Threading.Tasks.Task.ExecuteEntry(Boolean)
at System.Threading.Tasks.Task.System.Threading.IThreadPoolWorkItem.ExecuteWorkItem()
at System.Threading.ThreadPoolWorkQueue.Dispatch()
at System.Threading._ThreadPoolWaitCallback.PerformWaitCallback()


Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
<System>
<Provider Name=".NET Runtime" />
<EventID Qualifiers="0">1026</EventID>
<Level>2</Level>
<Task>0</Task>
<Keywords>0x80000000000000</Keywords>
<TimeCreated SystemTime="2017-01-05T07:11:11.276253900Z" />
<EventRecordID>6727</EventRecordID>
<Channel>Application</Channel>
<Computer>tvserver4.pexis.dnsalias.org</Computer>
<Security />
</System>
<EventData>
<Data>Application: MP2-Server.exe
Framework Version: v4.0.30319
Description: The process was terminated due to an unhandled exception.
Exception Info: System.AccessViolationException
at MediaInfoLib.MediaInfo.MediaInfpen(IntPtr, System.String)
at MediaInfoLib.MediaInfpen(System.String)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.ReadMediaInfo(MediaPortal.Common.ResourceAccess.IFileSystemResourceAccessor)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.TryExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1&lt;MediaPortal.Common.MediaManagement.IMetadataExtractor&gt;, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1&lt;System.Guid&gt;, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.ImporterWorkerDataflowBlockBase.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+&lt;ProcessMediaItem&gt;d__3.MoveNext()
at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].Start[[MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+&lt;ProcessMediaItem&gt;d__3, MediaPortal.Common, Version=2.1.1612.9730, Culture=neutral, PublicKeyToken=null]](&lt;ProcessMediaItem&gt;d__3 ByRef)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock.ProcessMediaItem(MediaPortal.Common.Services.MediaManagement.PendingImportResourceNewGen)
at System.Threading.Tasks.Dataflow.TransformBlock`2[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessageWithTask(System.Func`2&lt;System.__Canon,System.Threading.Tasks.Task`1&lt;System.__Canon&gt;&gt;, System.Collections.Generic.KeyValuePair`2&lt;System.__Canon,Int64&gt
at System.Threading.Tasks.Dataflow.TransformBlock`2+&lt;&gt;c__DisplayClass10[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].&lt;.ctor&gt;b__4(System.Collections.Generic.KeyValuePair`2&lt;System.__Canon,Int64&gt
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessagesLoopCore()
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].&lt;ProcessAsyncIfNecessary_Slow&gt;b__3(System.Object)
at System.Threading.Tasks.Task.InnerInvoke()
at System.Threading.Tasks.Task.Execute()
at System.Threading.Tasks.Task.ExecutionContextCallback(System.Object)
at System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.Tasks.Task.ExecuteWithThreadLocal(System.Threading.Tasks.Task ByRef)
at System.Threading.Tasks.Task.ExecuteEntry(Boolean)
at System.Threading.Tasks.Task.System.Threading.IThreadPoolWorkItem.ExecuteWorkItem()
at System.Threading.ThreadPoolWorkQueue.Dispatch()
at System.Threading._ThreadPoolWaitCallback.PerformWaitCallback()

</Data>
</EventData>
</Event>

Spoiler: Second

Log Name: Application
Source: .NET Runtime
Date: 5-1-2017 08:11:11
Event ID: 1026
Task Category: None
Level: Error
Keywords: Classic
User: N/A
Computer: tvserver4.pexis.dnsalias.org
Description:
Application: MP2-Server.exe
Framework Version: v4.0.30319
Description: The process was terminated due to an unhandled exception.
Exception Info: System.AccessViolationException
at MediaInfoLib.MediaInfo.MediaInfpen(IntPtr, System.String)
at MediaInfoLib.MediaInfpen(System.String)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.ReadMediaInfo(MediaPortal.Common.ResourceAccess.IFileSystemResourceAccessor)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.TryExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1<MediaPortal.Common.MediaManagement.IMetadataExtractor>, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1<System.Guid>, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.ImporterWorkerDataflowBlockBase.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2<System.Guid,System.Collections.Generic.IList`1<MediaPortal.Common.MediaManagement.MediaItemAspect>>, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+<ProcessMediaItem>d__3.MoveNext()
at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].Start[[MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+<ProcessMediaItem>d__3, MediaPortal.Common, Version=2.1.1612.9730, Culture=neutral, PublicKeyToken=null]](<ProcessMediaItem>d__3 ByRef)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock.ProcessMediaItem(MediaPortal.Common.Services.MediaManagement.PendingImportResourceNewGen)
at System.Threading.Tasks.Dataflow.TransformBlock`2[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessageWithTask(System.Func`2<System.__Canon,System.Threading.Tasks.Task`1<System.__Canon>>, System.Collections.Generic.KeyValuePair`2<System.__Canon,Int64>)
at System.Threading.Tasks.Dataflow.TransformBlock`2+<>c__DisplayClass10[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].<.ctor>b__4(System.Collections.Generic.KeyValuePair`2<System.__Canon,Int64>)
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessagesLoopCore()
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].<ProcessAsyncIfNecessary_Slow>b__3(System.Object)
at System.Threading.Tasks.Task.InnerInvoke()
at System.Threading.Tasks.Task.Execute()
at System.Threading.Tasks.Task.ExecutionContextCallback(System.Object)
at System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.Tasks.Task.ExecuteWithThreadLocal(System.Threading.Tasks.Task ByRef)
at System.Threading.Tasks.Task.ExecuteEntry(Boolean)
at System.Threading.Tasks.Task.System.Threading.IThreadPoolWorkItem.ExecuteWorkItem()
at System.Threading.ThreadPoolWorkQueue.Dispatch()
at System.Threading._ThreadPoolWaitCallback.PerformWaitCallback()


Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
<System>
<Provider Name=".NET Runtime" />
<EventID Qualifiers="0">1026</EventID>
<Level>2</Level>
<Task>0</Task>
<Keywords>0x80000000000000</Keywords>
<TimeCreated SystemTime="2017-01-05T07:11:11.276253900Z" />
<EventRecordID>6727</EventRecordID>
<Channel>Application</Channel>
<Computer>tvserver4.pexis.dnsalias.org</Computer>
<Security />
</System>
<EventData>
<Data>Application: MP2-Server.exe
Framework Version: v4.0.30319
Description: The process was terminated due to an unhandled exception.
Exception Info: System.AccessViolationException
at MediaInfoLib.MediaInfo.MediaInfpen(IntPtr, System.String)
at MediaInfoLib.MediaInfpen(System.String)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.ReadMediaInfo(MediaPortal.Common.ResourceAccess.IFileSystemResourceAccessor)
at MediaPortal.Extensions.MetadataExtractors.VideoMetadataExtractor.VideoMetadataExtractor.TryExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1&lt;MediaPortal.Common.MediaManagement.IMetadataExtractor&gt;, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.MediaAccessor.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IEnumerable`1&lt;System.Guid&gt;, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.ImporterWorkerDataflowBlockBase.ExtractMetadata(MediaPortal.Common.ResourceAccess.IResourceAccessor, System.Collections.Generic.IDictionary`2&lt;System.Guid,System.Collections.Generic.IList`1&lt;MediaPortal.Common.MediaManagement.MediaItemAspect&gt;&gt;, Boolean)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+&lt;ProcessMediaItem&gt;d__3.MoveNext()
at System.Runtime.CompilerServices.AsyncTaskMethodBuilder`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].Start[[MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock+&lt;ProcessMediaItem&gt;d__3, MediaPortal.Common, Version=2.1.1612.9730, Culture=neutral, PublicKeyToken=null]](&lt;ProcessMediaItem&gt;d__3 ByRef)
at MediaPortal.Common.Services.MediaManagement.ImportDataflowBlocks.MetadataExtractorBlock.ProcessMediaItem(MediaPortal.Common.Services.MediaManagement.PendingImportResourceNewGen)
at System.Threading.Tasks.Dataflow.TransformBlock`2[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessageWithTask(System.Func`2&lt;System.__Canon,System.Threading.Tasks.Task`1&lt;System.__Canon&gt;&gt;, System.Collections.Generic.KeyValuePair`2&lt;System.__Canon,Int64&gt
at System.Threading.Tasks.Dataflow.TransformBlock`2+&lt;&gt;c__DisplayClass10[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089],[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].&lt;.ctor&gt;b__4(System.Collections.Generic.KeyValuePair`2&lt;System.__Canon,Int64&gt
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].ProcessMessagesLoopCore()
at System.Threading.Tasks.Dataflow.Internal.TargetCore`1[[System.__Canon, mscorlib, Version=4.0.0.0, Culture=neutral, PublicKeyToken=b77a5c561934e089]].&lt;ProcessAsyncIfNecessary_Slow&gt;b__3(System.Object)
at System.Threading.Tasks.Task.InnerInvoke()
at System.Threading.Tasks.Task.Execute()
at System.Threading.Tasks.Task.ExecutionContextCallback(System.Object)
at System.Threading.ExecutionContext.RunInternal(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.ExecutionContext.Run(System.Threading.ExecutionContext, System.Threading.ContextCallback, System.Object, Boolean)
at System.Threading.Tasks.Task.ExecuteWithThreadLocal(System.Threading.Tasks.Task ByRef)
at System.Threading.Tasks.Task.ExecuteEntry(Boolean)
at System.Threading.Tasks.Task.System.Threading.IThreadPoolWorkItem.ExecuteWorkItem()
at System.Threading.ThreadPoolWorkQueue.Dispatch()
at System.Threading._ThreadPoolWaitCallback.PerformWaitCallback()

</Data>
</EventData>
</Event>

 

[HTPCSourcer]

what do you mean by "ALL level".

Please read the Wiki link that I provided and change log level as it is described there.

 

[HTPCSourcer]

That's why we need logs at DEBUG level ... This is defined with the key ALL in the config file (see Wiki)

 

[Fafnir]

That's why we need logs at DEBUG level

Here I come with the logs!
I changed the logging level according to your guidelines, hopefully this shows what you need.
It seems that I covered up another problem. ATM there is a schedule that won't be deleted. It still sticks around and does not allow to change the channel despite the fact that I deleted the record.

See the logs attached. Since this time the problem was kind of persistent, I had to make 3 logs...hopefully this ontributes to solving it.
Bye.

Fafnir

 

[HTPCSourcer]

I changed the logging level according to your guidelines, hopefully this shows what you need.

Unfortunately they are still at INFO level. When you changed the file, did you launch the editor with administrator privileges?

So if for example you are using Windows Notepad ("Editor") to adjust the config files from INFO to ALL, you will have to locate the executable in the Windows directory, right-click it and select Run as Administrator for your edit to work. Same for any other editor.
The one thing I am actually not 100& sure of is if you have to restart the MP2 server process for the change to take effect for the server logs. If you restart your PC and then launch only MP 2.1, you can be sure that changes have taken effect and no other software is possibly accessing MP files, but you may verify the config files to see if your ALL is still there..

It seems that I covered up another problem.

I can see that you tried to delete a recording at 20:40:49 which didn't work

2017-01-05 20:40:49,996] [388858 ] [InputMgr ] [ERROR] - Error deleting resource 'D:\Aufnahmen\Stargate Atlantis - TELE 5 - 2017-01-05_4.ts'
System.IO.IOException: Der Prozess kann nicht auf die Datei "D:\Aufnahmen\Stargate Atlantis - TELE 5 - 2017-01-05_4.ts" zugreifen, da sie von einem anderen Prozess verwendet wird.

There could be several reasons for this, e.g. Windows Explorer accessing the directory and file. To be sure, can you close all your other applications and try again?

Since this time the problem was kind of persistent

I am not sure which problem you are now referring to. Did you schedule a new recording and can't delete the programming?

When you upload new logs could you also please indicate at what time you observed which problem? Log files can be large and cover a long time-frame. Knowing approximately what happened when is helpful to locate the respective log parts.