Jump to content

Weird errors in log, things seem to be working ok-ish though...?


Recommended Posts

Posted

Is it normal to have a lot of errors in the log files on the server due to safety net checking or anything?  For instance one of my logs says this:

2017-02-25 23:56:48.3051 Info HttpServer: HTTP Response 404 to 192.168.1.72. Time: 1ms. http://192.168.1.15:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events
2017-02-25 23:56:48.3351 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 449ms. http://192.168.1.5:8096/Items/aa1b3bf01e0f2cf686546e6c76a5b6db/Images/Primary/0/88cd1f26d1ae784d1caa547e3e0f11bd/jpg/4096/4096/0/0
2017-02-25 23:56:49.3121 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/5c819e3828dfcb44b40c5ae001975957/Images/Primary/0/4a17cbd27fcf11bbec7164d7ecccfbae/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:56:49.3121 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 3ms. http://192.168.1.5:8096/Items/5c819e3828dfcb44b40c5ae001975957/Images/Primary/0/4a17cbd27fcf11bbec7164d7ecccfbae/jpg/4096/4096/0/0
2017-02-25 23:56:53.2764 Info HttpServer: HTTP GET http://192.168.1.15:8096/Items/b5497e5f847bb5aab6f804b38d755a4f/Images/Primary/0/4bfe0fa3c34345a5f3eeb67c3f67e791/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 7.0; SHIELD Android TV Build/NRD90M)
2017-02-25 23:56:54.4595 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.15:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events. UserAgent: 
2017-02-25 23:56:54.4595 Error HttpServer: Error processing request
	*** Error Report ***
	Version: 3.2.4.0

A lot of times it repeats constantly:

	Version: 3.2.4.0
	Command line: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System\MediaBrowser.ServerApplication.exe
	Operating system: Microsoft Windows NT 6.2.9200.0
	64-Bit OS: True
	64-Bit Process: True
	Processor count: 24
	Program data path: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server
	Application directory: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System
	MediaBrowser.Common.Extensions.ResourceNotFoundException: Event with Id uuid:4d81b0c89f7b4a88b68505bc387d268e not found.
	   at Emby.Dlna.Eventing.EventManager.GetSubscription(String id, Boolean throwOnMissing)
	   at Emby.Dlna.Eventing.EventManager.RenewEventSubscription(String subscriptionId, Nullable`1 timeoutSeconds)
	   at MediaBrowser.Api.Dlna.DlnaServerService.ProcessEventRequest(IEventManager eventManager)
	   at lambda_method(Closure , Object , Object )
	   at Emby.Server.Implementations.Services.ServiceExecGeneral.<Execute>d__2.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceController.<Execute>d__13.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceHandler.<ProcessRequestAsync>d__15.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.HttpServer.HttpListenerHost.<RequestHandler>d__74.MoveNext()
	MediaBrowser.Common.Extensions.ResourceNotFoundException
	   at Emby.Dlna.Eventing.EventManager.GetSubscription(String id, Boolean throwOnMissing)
	   at Emby.Dlna.Eventing.EventManager.RenewEventSubscription(String subscriptionId, Nullable`1 timeoutSeconds)
	   at MediaBrowser.Api.Dlna.DlnaServerService.ProcessEventRequest(IEventManager eventManager)
	   at lambda_method(Closure , Object , Object )
	   at Emby.Server.Implementations.Services.ServiceExecGeneral.<Execute>d__2.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceController.<Execute>d__13.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceHandler.<ProcessRequestAsync>d__15.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.HttpServer.HttpListenerHost.<RequestHandler>d__74.MoveNext()
	
2017-02-25 23:56:18.2879 Info HttpServer: HTTP Response 404 to 192.168.1.72. Time: 1ms. http://192.168.1.15:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events
2017-02-25 23:56:24.3753 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.15:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events. UserAgent: 
2017-02-25 23:56:24.3753 Error HttpServer: Error processing request
	*** Error Report ***
	Version: 3.2.4.0

This is a fresh install on a windows 2012 R2 server... I had hundreds of errors on various movies that I have to re-identify.  I only have about 500 movies - haven't done anything except movies so far and I've hit a snag.  Some movies let me update the identity just fine, while others spit out errors in the log file about not having permission to the file...?  It's the same file it created itself with NO weird permission issues happening or assigned to root folders for inheritance or such.  

Here's an example of it not updating the jpg files and something about "MaybeFullPath" being an error too?...

	Version: 3.2.4.0
	Command line: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System\MediaBrowser.ServerApplication.exe
	Operating system: Microsoft Windows NT 6.2.9200.0
	64-Bit OS: True
	64-Bit Process: True
	Processor count: 24
	Program data path: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server
	Application directory: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System
	System.AggregateException: One or more errors occurred. ---> System.UnauthorizedAccessException: Access to the path 'P:\Video\Movies\Twilight Saga\Twilight-fanart.jpg' is denied.
	   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
	   at System.IO.File.InternalDelete(String path, Boolean checkHost)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.ClearImages(IHasImages item, ImageType type)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.<RefreshImages>d__6.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.MetadataService`2.<RefreshMetadata>d__7.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Controller.Entities.BaseItem.<RefreshMetadata>d__366.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.ProviderManager.<RefreshItem>d__60.MoveNext()
	   --- End of inner exception stack trace ---
	   at System.Threading.Tasks.Task.WaitAll(Task[] tasks, Int32 millisecondsTimeout, CancellationToken cancellationToken)
	   at MediaBrowser.Api.ItemLookupService.Post(ApplySearchCriteria request)
	   at Emby.Server.Implementations.Services.ServiceExecGeneral.<>c__DisplayClass4_0.<CreateExecFn>b__0(Object service, Object request)
	   at Emby.Server.Implementations.Services.ServiceExecGeneral.<Execute>d__2.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceController.<Execute>d__13.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceHandler.<ProcessRequestAsync>d__15.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.HttpServer.HttpListenerHost.<RequestHandler>d__74.MoveNext()
	---> (Inner Exception #0) System.UnauthorizedAccessException: Access to the path 'P:\Video\Movies\Twilight Saga\Twilight-fanart.jpg' is denied.
	   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
	   at System.IO.File.InternalDelete(String path, Boolean checkHost)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.ClearImages(IHasImages item, ImageType type)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.<RefreshImages>d__6.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.MetadataService`2.<RefreshMetadata>d__7.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Controller.Entities.BaseItem.<RefreshMetadata>d__366.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.ProviderManager.<RefreshItem>d__60.MoveNext()<---
	
	System.AggregateException
	   at System.Threading.Tasks.Task.WaitAll(Task[] tasks, Int32 millisecondsTimeout, CancellationToken cancellationToken)
	   at MediaBrowser.Api.ItemLookupService.Post(ApplySearchCriteria request)
	   at Emby.Server.Implementations.Services.ServiceExecGeneral.<>c__DisplayClass4_0.<CreateExecFn>b__0(Object service, Object request)
	   at Emby.Server.Implementations.Services.ServiceExecGeneral.<Execute>d__2.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceController.<Execute>d__13.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.Services.ServiceHandler.<ProcessRequestAsync>d__15.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Server.Implementations.HttpServer.HttpListenerHost.<RequestHandler>d__74.MoveNext()
	InnerException: System.UnauthorizedAccessException
	System.UnauthorizedAccessException: Access to the path 'P:\Video\Movies\Twilight Saga\Twilight-fanart.jpg' is denied.
	   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
	   at System.IO.File.InternalDelete(String path, Boolean checkHost)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.ClearImages(IHasImages item, ImageType type)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.<RefreshImages>d__6.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.MetadataService`2.<RefreshMetadata>d__7.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Controller.Entities.BaseItem.<RefreshMetadata>d__366.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.ProviderManager.<RefreshItem>d__60.MoveNext()
	   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
	   at System.IO.File.InternalDelete(String path, Boolean checkHost)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.ClearImages(IHasImages item, ImageType type)
	   at MediaBrowser.Providers.Manager.ItemImageProvider.<RefreshImages>d__6.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.MetadataService`2.<RefreshMetadata>d__7.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Controller.Entities.BaseItem.<RefreshMetadata>d__366.MoveNext()
	--- End of stack trace from previous location where exception was thrown ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at MediaBrowser.Providers.Manager.ProviderManager.<RefreshItem>d__60.MoveNext()
	
2017-02-25 23:50:12.2170 Info HttpServer: HTTP Response 500 to 192.168.1.6. Time: 981ms. http://alpha.it-tank.com:8096/emby/Items/RemoteSearch/Apply/9fa78147b337a4a6b200ff89c16b52d3?ReplaceAllImages=true
2017-02-25 23:50:15.9352 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/6ea7d56bd1f2d95f79c8bcf88e321688/Images/Primary/0/1bb45d3d173698b9a97df2386b225864/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:15.9393 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 4ms. http://192.168.1.5:8096/Items/6ea7d56bd1f2d95f79c8bcf88e321688/Images/Primary/0/1bb45d3d173698b9a97df2386b225864/jpg/4096/4096/0/0
2017-02-25 23:50:16.6843 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/441298491f844cd13b43e36f93359bc9/Images/Primary/0/5a86d02149a2f1d0374c2427fac510ee/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:16.6843 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 4ms. http://192.168.1.5:8096/Items/441298491f844cd13b43e36f93359bc9/Images/Primary/0/5a86d02149a2f1d0374c2427fac510ee/jpg/4096/4096/0/0
2017-02-25 23:50:17.4074 Info HttpServer: HTTP POST http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/control. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:17.4074 Info Dlna: No matching device profile found. The default will need to be used.
	Content-Type: text/xml; charset=utf-8
	Soapaction: "urn:schemas-upnp-org:service:ContentDirectory:1#Search"
	User-Agent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
	Host: 192.168.1.5:8096
	Connection: Keep-Alive
	Accept-Encoding: gzip
	Content-Length: 541
2017-02-25 23:50:17.5114 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 104ms. http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/control
2017-02-25 23:50:17.6004 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/8b74192968179dabbf568e01650538b1/Images/Primary/0/9a4236db07f29c1d3842ce91791db806/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:17.7394 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/connectionmanager/events. UserAgent: Linux/3.10.19-p.36.deua.k2lp.13 UPnP/1.0 LGE WebOS TV LGE_DLNA_SDK/1.6.0/04.30.70 DLNADOC/1.50
2017-02-25 23:50:17.7394 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events. UserAgent: Linux/3.10.19-p.36.deua.k2lp.13 UPnP/1.0 LGE WebOS TV LGE_DLNA_SDK/1.6.0/04.30.70 DLNADOC/1.50
2017-02-25 23:50:17.7394 Info HttpServer: HTTP Response 200 to 192.168.1.171. Time: 1ms. http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/connectionmanager/events
2017-02-25 23:50:17.7394 Info HttpServer: HTTP Response 200 to 192.168.1.171. Time: 1ms. http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events
2017-02-25 23:50:17.7394 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events. UserAgent: Linux/3.10.19-p.36.deua.k2lp.13 UPnP/1.0 LGE WebOS TV LGE_DLNA_SDK/1.6.0/04.30.70 DLNADOC/1.50
2017-02-25 23:50:17.7394 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/connectionmanager/events. UserAgent: Linux/3.10.19-p.36.deua.k2lp.13 UPnP/1.0 LGE WebOS TV LGE_DLNA_SDK/1.6.0/04.30.70 DLNADOC/1.50
2017-02-25 23:50:17.7394 Info HttpServer: HTTP Response 200 to 192.168.1.171. Time: 0ms. http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/connectionmanager/events
2017-02-25 23:50:17.7394 Info HttpServer: HTTP Response 200 to 192.168.1.171. Time: 0ms. http://192.168.1.5:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events
2017-02-25 23:50:18.0024 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 403ms. http://192.168.1.5:8096/Items/8b74192968179dabbf568e01650538b1/Images/Primary/0/9a4236db07f29c1d3842ce91791db806/jpg/4096/4096/0/0
2017-02-25 23:50:18.6035 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/c79628d520716dd4e1175b459a73e5a4/Images/Primary/0/15e67a3b6a2ef9b206baf85a2026e8fd/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:18.7114 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 108ms. http://192.168.1.5:8096/Items/c79628d520716dd4e1175b459a73e5a4/Images/Primary/0/15e67a3b6a2ef9b206baf85a2026e8fd/jpg/4096/4096/0/0
2017-02-25 23:50:19.4295 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/5e4014388f288bb16a7f6f78beaf154e/Images/Primary/0/a36e49aa80058209b43b2ba04b4999b1/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:19.5085 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 79ms. http://192.168.1.5:8096/Items/5e4014388f288bb16a7f6f78beaf154e/Images/Primary/0/a36e49aa80058209b43b2ba04b4999b1/jpg/4096/4096/0/0
2017-02-25 23:50:20.2196 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/cd478a5564b1ce09bd5230d28e4e8829/Images/Primary/0/1797ee2983ef524c252b91bd58982a18/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:20.2246 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 5ms. http://192.168.1.5:8096/Items/cd478a5564b1ce09bd5230d28e4e8829/Images/Primary/0/1797ee2983ef524c252b91bd58982a18/jpg/4096/4096/0/0
2017-02-25 23:50:21.1196 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/926ee65edd8e2ae44399cfc73e8cdb19/Images/Primary/0/5c1427c63ed69dd342fcf4260b30e576/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:21.1196 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 5ms. http://192.168.1.5:8096/Items/926ee65edd8e2ae44399cfc73e8cdb19/Images/Primary/0/5c1427c63ed69dd342fcf4260b30e576/jpg/4096/4096/0/0
2017-02-25 23:50:22.0047 Info HttpServer: HTTP GET http://192.168.1.5:8096/Items/fc523f1c887633446d00f0084f3533f4/Images/Primary/0/9584b065797e88a4d33917732e9f5e6e/jpg/4096/4096/0/0. UserAgent: Dalvik/2.1.0 (Linux; U; Android 5.1.1; KFFOWI Build/LVY48F)
2017-02-25 23:50:22.0047 Info HttpServer: HTTP Response 200 to 192.168.1.59. Time: 4ms. http://192.168.1.5:8096/Items/fc523f1c887633446d00f0084f3533f4/Images/Primary/0/9584b065797e88a4d33917732e9f5e6e/jpg/4096/4096/0/0
2017-02-25 23:50:30.6843 Info HttpServer: HTTP GET http://localhost:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2017-02-25T05%3A50%3A30.680Z. UserAgent: Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-25 23:50:30.6923 Info HttpS 

Here is an example from it trying to update the nfo file to a TV episode:

	Version: 3.2.4.0
	Command line: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System\MediaBrowser.ServerApplication.exe
	Operating system: Microsoft Windows NT 6.2.9200.0
	64-Bit OS: True
	64-Bit Process: True
	Processor count: 24
	Program data path: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server
	Application directory: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System
	System.UnauthorizedAccessException: Access to the path 'D:\Video\PlayLater\E.R\ER Season 02\er.s02e07.hell.and.high.water.fs.nfo' is denied.
	   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
	   at System.IO.FileStream.Init(String path, FileMode mode, FileAccess access, Int32 rights, Boolean useRights, FileShare share, Int32 bufferSize, FileOptions options, SECURITY_ATTRIBUTES secAttrs, String msgPath, Boolean bFromProxy, Boolean useLongPath, Boolean checkHost)
	   at System.IO.FileStream..ctor(String path, FileMode mode, FileAccess access, FileShare share, Int32 bufferSize)
	   at Emby.Common.Implementations.IO.ManagedFileSystem.GetFileStream(String path, FileOpenMode mode, FileAccessMode access, FileShareMode share, Boolean isAsync)
	   at MediaBrowser.XbmcMetadata.Savers.BaseNfoSaver.SaveToFile(Stream stream, String path)
	   at MediaBrowser.XbmcMetadata.Savers.BaseNfoSaver.Save(IHasMetadata item, CancellationToken cancellationToken)
	   at MediaBrowser.Providers.Manager.ProviderManager.<SaveMetadata>d__47.MoveNext()
	System.UnauthorizedAccessException
	   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
	   at System.IO.FileStream.Init(String path, FileMode mode, FileAccess access, Int32 rights, Boolean useRights, FileShare share, Int32 bufferSize, FileOptions options, SECURITY_ATTRIBUTES secAttrs, String msgPath, Boolean bFromProxy, Boolean useLongPath, Boolean checkHost)
	   at System.IO.FileStream..ctor(String path, FileMode mode, FileAccess access, FileShare share, Int32 bufferSize)
	   at Emby.Common.Implementations.IO.ManagedFileSystem.GetFileStream(String path, FileOpenMode mode, FileAccessMode access, FileShareMode share, Boolean isAsync)
	   at MediaBrowser.XbmcMetadata.Savers.BaseNfoSaver.SaveToFile(Stream stream, String path)
	   at MediaBrowser.XbmcMetadata.Savers.BaseNfoSaver.Save(IHasMetadata item, CancellationToken cancellationToken)
	   at MediaBrowser.Providers.Manager.ProviderManager.<SaveMetadata>d__47.MoveNext()
	
2017-02-25 23:53:18.7152 Info HttpServer: HTTP Response 204 to 192.168.1.6. Time: 3118ms (slow). http://alpha.it-tank.com:8096/emby/Items/RemoteSearch/Apply/9fa78147b337a4a6b200ff89c16b52d3?ReplaceAllImages=true
2017-02-25 23:53:19.9373 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.15:8096/dlna/dc5e8ba576e04297ae69e1d94e5d22af/contentdirectory/events. UserAgent: 
2017-02-25 23:53:19.9373 Error HttpServer: Error processing request
	*** Error Report ***
	Version: 3.2.4.0

I also see things like internal server errors, port mapping errors, and metadata savers:

	System.AggregateException
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Common.Implementations.HttpClientManager.HttpClientManager.<SendAsyncInternal>d__22.MoveNext()
	InnerException: System.Net.WebException
	System.Net.WebException: The remote server returned an error: (500) Internal Server Error.
	   at System.Net.HttpWebRequest.EndGetResponse(IAsyncResult asyncResult)
	   at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization)
	   at System.Net.HttpWebRequest.EndGetResponse(IAsyncResult asyncResult)
	   at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization)
	
2017-02-25 23:53:15.9740 Error PortMapper: Error creating port map: One or more errors occurred.
2017-02-25 23:53:15.9740 Error PortMapper: Error creating port map: One or more errors occurred.
2017-02-25 23:53:15.9920 Info HttpClient: HttpClientManager GET: https://api.themoviedb.org/3/movie/26269?api_key=f6bd687ffa63cd282b6ff2c6877f2669&append_to_response=casts,releases,images,keywords,trailers
2017-02-25 23:53:16.1161 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/1G9PZLULbbIrb74H6BdhQGplCxf.jpg
2017-02-25 23:53:16.3490 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/9GWwEBppULimzFvuNlxqlkQxNCE.jpg
2017-02-25 23:53:16.6050 Info HttpClient: HttpClientManager GET: https://webservice.fanart.tv/v3/movies/26269?api_key=5c6b04c68e904cfed1e6cbc9a9e683d4
2017-02-25 23:53:16.9551 Info HttpClient: HttpClientManager GET: https://assets.fanart.tv/fanart/movies/26269/hdmovielogo/twilight-55e6dd069f338.png
2017-02-25 23:53:17.3711 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/n6y6VxJKf0tNC2xFvbsAgcOeLbg.jpg
2017-02-25 23:53:18.2762 Error ProviderManager: Error in metadata saver
	*** Error Report ***

Lots of repeats:

	System.Net.WebException: The remote server returned an error: (500) Internal Server Error.
	   at System.Net.HttpWebRequest.EndGetResponse(IAsyncResult asyncResult)
	   at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization)
	   at System.Net.HttpWebRequest.EndGetResponse(IAsyncResult asyncResult)
	   at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization)
	
2017-02-25 23:53:15.9740 Error HttpClient: Error getting response from http://192.168.1.33:49152
	*** Error Report ***
	Version: 3.2.4.0
	Command line: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System\MediaBrowser.ServerApplication.exe
	Operating system: Microsoft Windows NT 6.2.9200.0
	64-Bit OS: True
	64-Bit Process: True
	Processor count: 24
	Program data path: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server
	Application directory: C:\Users\administrator.IT-TANK\AppData\Roaming\Emby-Server\System
	System.AggregateException: One or more errors occurred. ---> System.Net.WebException: The remote server returned an error: (500) Internal Server Error.
	   at System.Net.HttpWebRequest.EndGetResponse(IAsyncResult asyncResult)
	   at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization)
	   --- End of inner exception stack trace ---
	   at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task)
	   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
	   at Emby.Common.Implementations.HttpClientManager.HttpClientManager.<SendAsyncInternal>d__22.MoveNext()
	---> (Inner Exception #0) System.Net.WebException: The remote server returned an error: (500) Internal Server Error.

Just not sure what to make of it, since it seems to function well.  Most of the access errors have cleared up after I set the "everyone" value to full RW permissions and replace all other permissions inherently.  But I'm still seeing some internal server errors, as well as the DNLA subscribe errors.  

 

How big are these log files going to get and do they recycle/rotate?  I've only had the server up for 4 days and I've got over 67MB of just "server-number.txt" files... that's a lot of text.  

 

Anyone know what's going on here? Is this common?  I'm a stickler for clean logs.... this is hurting my anal retentive nature.  :)

Posted

your dlna devices are sending data based on the previous server installation. we could probably just not log it at all in that situation.

Posted (edited)

I had emby installed on a test box first and then did a full/real install on the server box... I removed the test box from my account... so what should I do to remedy the error?  How can I not log anything dnla related?  Is that what you're suggesting?

Edit: You don't sleep much do you Luke? :)

Edited by gleep52
Posted

If you just go back to those devices and log into the new server i think that will take care of it.

Posted

I have a Kindle Fire, and a nVidia Shield TV both using an app fotodream for my screensaver which pulls jpg's from emby's DNLA service.  I reselected the dnla server on both devices, restarted the server, let it run for a few minutes and restarted it again to release the log.  Looks like the error is still there - it's attached here so you can look and see if I'm understanding it right.  I have two NICs on my server (alpha .5 and .15)  It looks like SUBSCRIBE events are working on .5, but always crash when they hit .15... could that be the problem?

server-63623666971.txt

Posted

Just because you restricted it does not mean the device won't keep retrying. What we really should just do is not log anything so that there's never any chance of a perceived problem.

Posted

Just because you restricted it does not mean the device won't keep retrying. What we really should just do is not log anything so that there's never any chance of a perceived problem.

 

I'd be fine with ignoring all DNLA errors - but how do I go about excluding those?

Posted

Just because you restricted it does not mean the device won't keep retrying. What we really should just do is not log anything so that there's never any chance of a perceived problem.

 BTW - my server isn't bound to either IP - it's free game, which makes me wonder if I should bind a specific IP... I'd rather not to get full bandwidth, but if you think that might help?

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
×
×
  • Create New...