Darkieth 0 Posted July 28, 2018 Share Posted July 28, 2018 (edited) Server lasts a few minutes before crashing and requiring a manual start. Been working fine and I haven't altered anything recently. Somewhat inept at reading logs so could anyone tell me what's causing it? Thanks in advance. EDIT: Currently been up for around 30 minutes without crashing, perhaps solved itself. System.IO.IOException: Unable to read data from the transport connection: Connection reset by peer. ---> System.Net.Sockets.SocketException: Connection reset by peer --- End of inner exception stack trace --- at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error) at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.GetResult(Int16 token) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Net.Security.SslState.ThrowIfExceptional() at System.Net.Security.SslState.CheckThrow(Boolean authSuccessCheck, Boolean shutdownCheck) at System.Net.Security.SslState.CheckOldKeyDecryptedData(Memory`1 buffer) at System.Net.Security.SslState.HandleQueuedCallback(Object& queuedStateRequest) at System.Net.Security.SslState.FinishHandshakeRead(Int32 newState) at System.Net.Security.SslState.FinishHandshake(Exception e, AsyncProtocolRequest asyncRequest) at System.Net.Security.SslState.RehandshakeCompleteCallback(IAsyncResult result) at System.Net.LazyAsyncResult.Complete(IntPtr userToken) at System.Net.LazyAsyncResult.ProtectedInvokeCallback(Object result, IntPtr userToken) at System.Net.AsyncProtocolRequest.CompleteUserWithError(Exception e) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state) --- End of stack trace from previous location where exception was thrown --- at System.Threading.ThreadPoolWorkQueue.Dispatch() System.IO.IOException at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error) at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.GetResult(Int16 token) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Net.Security.SslState.ThrowIfExceptional() at System.Net.Security.SslState.CheckThrow(Boolean authSuccessCheck, Boolean shutdownCheck) at System.Net.Security.SslState.CheckOldKeyDecryptedData(Memory`1 buffer) at System.Net.Security.SslState.HandleQueuedCallback(Object& queuedStateRequest) at System.Net.Security.SslState.FinishHandshakeRead(Int32 newState) at System.Net.Security.SslState.FinishHandshake(Exception e, AsyncProtocolRequest asyncRequest) at System.Net.Security.SslState.RehandshakeCompleteCallback(IAsyncResult result) at System.Net.LazyAsyncResult.Complete(IntPtr userToken) at System.Net.LazyAsyncResult.ProtectedInvokeCallback(Object result, IntPtr userToken) at System.Net.AsyncProtocolRequest.CompleteUserWithError(Exception e) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state) --- End of stack trace from previous location where exception was thrown --- at System.Threading.ThreadPoolWorkQueue.Dispatch() InnerException: System.Net.Sockets.SocketException System.Net.Sockets.SocketException (104): Connection reset by peer 2018-07-28 13:50:47.091 Info Main: Application path: /opt/emby-server/system/EmbyServer.dll 2018-07-28 13:50:47.099 Info Main: Emby Command line: /opt/emby-server/system/EmbyServer.dll -programdata /var/lib/emby -ffmpeg /opt/emby-server/bin/ffmpeg -ffprobe /opt/emby-server/bin/ffprobe -restartexitcode 3 -updatepackage emby-server-deb_{version}_amd64.deb Operating system: Unix 4.15.0.24 64-Bit OS: True 64-Bit Process: True User Interactive: True Processor count: 6 Program data path: /var/lib/emby Application directory: /opt/emby-server/system 2018-07-28 13:50:47.307 Info App: Application version: 3.6.0.2 2018-07-28 13:50:47.308 Info App: Loading assemblies 2018-07-28 13:50:47.330 Info App: File /var/lib/emby/plugins/Emby.Server.CinemaMode.dll has version 1.0.2.0 2018-07-28 13:50:47.330 Info App: File /opt/emby-server/system/plugins/Emby.Server.CinemaMode.dll has version 1.0.2.0 2018-07-28 13:50:47.330 Info App: File /var/lib/emby/plugins/OpenSubtitles.dll has version 1.0.2.0 2018-07-28 13:50:47.330 Info App: File /opt/emby-server/system/plugins/OpenSubtitles.dll has version 1.0.2.0 2018-07-28 13:50:47.330 Info App: File /var/lib/emby/plugins/IMVDb.dll has version 1.0.1.0 2018-07-28 13:50:47.330 Info App: File /opt/emby-server/system/plugins/IMVDb.dll has version 1.0.1.0 2018-07-28 13:50:47.342 Info App: Loading Emby.Server.CinemaMode, Version=1.0.2.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/Emby.Server.CinemaMode.dll 2018-07-28 13:50:47.342 Info App: Loading PodCasts, Version=1.1.4.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/PodCasts.dll 2018-07-28 13:50:47.342 Info App: Loading OpenSubtitles, Version=1.0.2.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/OpenSubtitles.dll 2018-07-28 13:50:47.342 Info App: Loading IMVDb, Version=1.0.1.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/IMVDb.dll 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.Plugins.Anime, Version=1.2.8.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/MediaBrowser.Plugins.Anime.dll 2018-07-28 13:50:47.342 Info App: Loading MBBackup, Version=1.2.3.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/MBBackup.dll 2018-07-28 13:50:47.342 Info App: Loading Lastfm, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/Lastfm.dll 2018-07-28 13:50:47.342 Info App: Loading statistics, Version=2.0.5.1, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/Statistics.dll 2018-07-28 13:50:47.342 Info App: Loading AutoBoxSets, Version=1.1.3.0, Culture=neutral, PublicKeyToken=null from /var/lib/emby/plugins/AutoBoxSets.dll 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.Api, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.WebDashboard, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.Model, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.Common, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.Controller, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.Providers, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading Emby.Photos, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading Emby.Server.Implementations, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading Emby.Server.MediaEncoding, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading Emby.Dlna, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.LocalMetadata, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading Emby.Notifications, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading MediaBrowser.XbmcMetadata, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading Emby.Server.Connect, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.342 Info App: Loading Emby.Server.Sync, Version=3.6.0.2, Culture=neutral, PublicKeyToken=null 2018-07-28 13:50:47.500 Info SqliteUserRepository: Sqlite version: 3.24.0 2018-07-28 13:50:47.501 Info SqliteUserRepository: Sqlite compiler options: COMPILER=gcc-6.3.0,ENABLE_COLUMN_METADATA,ENABLE_DBSTAT_VTAB,ENABLE_FTS3,ENABLE_FTS3_PARENTHESIS,ENABLE_FTS3_TOKENIZER,ENABLE_FTS5,ENABLE_JSON1,ENABLE_PREUPDATE_HOOK,ENABLE_RTREE,ENABLE_SESSION,ENABLE_UNLOCK_NOTIFY,ENABLE_UPDATE_DELETE_LIMIT,LIKE_DOESNT_MATCH_BLOBS,MAX_SCHEMA_RETRY=25,MAX_VARIABLE_NUMBER=250000,OMIT_LOOKASIDE,SECURE_DELETE,THREADSAFE=1 2018-07-28 13:50:47.532 Info SqliteUserRepository: Default journal_mode for /var/lib/emby/data/users.db is wal 2018-07-28 13:50:47.534 Info SqliteUserRepository: PRAGMA synchronous=1 2018-07-28 13:50:47.549 Info AuthenticationRepository: Default journal_mode for /var/lib/emby/data/authentication.db is wal 2018-07-28 13:50:47.549 Info AuthenticationRepository: PRAGMA synchronous=1 2018-07-28 13:50:47.640 Info ActivityRepository: Default journal_mode for /var/lib/emby/data/activitylog.db is wal 2018-07-28 13:50:47.640 Info ActivityRepository: PRAGMA synchronous=1 2018-07-28 13:50:47.645 Info SqliteDisplayPreferencesRepository: Default journal_mode for /var/lib/emby/data/displaypreferences.db is wal 2018-07-28 13:50:47.645 Info SqliteDisplayPreferencesRepository: PRAGMA synchronous=1 2018-07-28 13:50:47.759 Debug XmlSerializer: Deserializing file /var/lib/emby/config/users/3e1877189f324bf39c09d62a15459328/policy.xml 2018-07-28 13:50:47.808 Info SqliteItemRepository: Default journal_mode for /var/lib/emby/data/library.db is wal 2018-07-28 13:50:47.809 Info SqliteItemRepository: PRAGMA synchronous=1 2018-07-28 13:50:47.897 Debug XmlSerializer: Deserializing file /var/lib/emby/config/encoding.xml 2018-07-28 13:50:48.005 Info HttpServer: Calling ServiceStack AppHost.Init 2018-07-28 13:50:48.539 Info HttpServer: Adding HttpListener prefix http://+:8096/ 2018-07-28 13:50:48.540 Info HttpServer: Adding HttpListener prefix https://+:8920/ 2018-07-28 13:50:48.845 Info Skia: SkiaSharp version: 1.60.0.0 2018-07-28 13:50:48.876 Info TaskManager: Daily trigger for Configuration Backup set to fire at 7/29/18 12:10:00 AM, which is 619.185401336667 minutes from now. 2018-07-28 13:50:48.908 Info TaskManager: Daily trigger for Calculate statistics for all users set to fire at 7/29/18 5:00:00 AM, which is 909.184861465 minutes from now. 2018-07-28 13:50:48.912 Info TaskManager: Daily trigger for Chapter image extraction set to fire at 7/29/18 2:00:00 AM, which is 729.184800156667 minutes from now. 2018-07-28 13:50:48.917 Info TaskManager: Daily trigger for Rotate log file set to fire at 7/29/18 12:00:00 AM, which is 609.18470195 minutes from now. 2018-07-28 13:50:48.923 Info MediaEncoder: FFMpeg: /opt/emby-server/bin/ffmpeg 2018-07-28 13:50:48.923 Info MediaEncoder: FFProbe: /opt/emby-server/bin/ffprobe 2018-07-28 13:50:48.923 Info MediaEncoder: Validating media encoder at /opt/emby-server/bin/ffmpeg 2018-07-28 13:50:48.926 Info MediaEncoder: Running /opt/emby-server/bin/ffmpeg -decoders 2018-07-28 13:50:48.985 Info MediaEncoder: Decoder available: mpeg2video 2018-07-28 13:50:48.990 Info MediaEncoder: Decoder available: h264_cuvid 2018-07-28 13:50:48.990 Info MediaEncoder: Decoder available: hevc_cuvid 2018-07-28 13:50:48.990 Info MediaEncoder: Decoder available: mpeg2_cuvid 2018-07-28 13:50:48.991 Info MediaEncoder: Decoder available: mpeg4_cuvid 2018-07-28 13:50:48.991 Info MediaEncoder: Decoder available: vc1_cuvid 2018-07-28 13:50:48.991 Info MediaEncoder: Decoder available: vp8_cuvid 2018-07-28 13:50:48.991 Info MediaEncoder: Decoder available: vp9_cuvid 2018-07-28 13:50:48.996 Info MediaEncoder: Decoder available: ac3 2018-07-28 13:50:48.996 Info MediaEncoder: Decoder available: aac 2018-07-28 13:50:48.997 Info MediaEncoder: Decoder available: mp3 2018-07-28 13:50:48.997 Info MediaEncoder: Decoder available: h264 2018-07-28 13:50:48.997 Info MediaEncoder: Decoder available: hevc 2018-07-28 13:50:49.002 Info MediaEncoder: Running /opt/emby-server/bin/ffmpeg -encoders 2018-07-28 13:50:49.055 Info MediaEncoder: Encoder available: libx264 2018-07-28 13:50:49.055 Info MediaEncoder: Encoder available: mpeg4 2018-07-28 13:50:49.055 Info MediaEncoder: Encoder available: msmpeg4 2018-07-28 13:50:49.057 Info MediaEncoder: Encoder available: aac 2018-07-28 13:50:49.057 Info MediaEncoder: Encoder available: libmp3lame 2018-07-28 13:50:49.057 Info MediaEncoder: Encoder available: libopus 2018-07-28 13:50:49.057 Info MediaEncoder: Encoder available: libvorbis 2018-07-28 13:50:49.058 Info MediaEncoder: Encoder available: srt 2018-07-28 13:50:49.058 Info MediaEncoder: Encoder available: h264_nvenc 2018-07-28 13:50:49.058 Info MediaEncoder: Encoder available: hevc_nvenc 2018-07-28 13:50:49.061 Info MediaEncoder: Encoder available: h264_vaapi 2018-07-28 13:50:49.061 Info MediaEncoder: Encoder available: hevc_vaapi 2018-07-28 13:50:49.061 Info MediaEncoder: Encoder available: h264_v4l2m2m 2018-07-28 13:50:49.061 Info MediaEncoder: Encoder available: libwebp 2018-07-28 13:50:49.061 Info MediaEncoder: Encoder available: ac3 2018-07-28 13:50:49.063 Info MediaEncoder: Running /opt/emby-server/bin/ffmpeg -protocols 2018-07-28 13:50:49.111 Info MediaEncoder: Encoder validation complete 2018-07-28 13:50:49.111 Info MediaEncoder: ffmpeg supported protocols: async,cache,concat,crypto,data,ffrtmphttp,file,ftp,gopher,hls,http,httpproxy,https,mmsh,mmst,pipe,rtmp,rtmps,rtmpt,rtmpts,rtp,srtp,subfile,tcp,tls,udp,udplite,unix,smb 2018-07-28 13:50:49.113 Info App: ServerId: b2136b5f44634897ad34c3300667d1cc 2018-07-28 13:50:49.184 Info App: Starting entry point MediaBrowser.WebDashboard.ServerEntryPoint 2018-07-28 13:50:49.186 Info App: Entry point completed: MediaBrowser.WebDashboard.ServerEntryPoint. Duration: 0.0015308 seconds 2018-07-28 13:50:49.186 Info App: Starting entry point Emby.Dlna.Main.DlnaEntryPoint 2018-07-28 13:50:49.193 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Bravia (2012).xml 2018-07-28 13:50:49.300 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/foobar2000.xml 2018-07-28 13:50:49.300 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Bravia (2014).xml 2018-07-28 13:50:49.301 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Bravia (2013).xml 2018-07-28 13:50:49.302 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony PlayStation 3.xml 2018-07-28 13:50:49.302 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/DirecTV HD-DVR.xml 2018-07-28 13:50:49.303 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/MediaMonkey.xml 2018-07-28 13:50:49.303 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Blu-ray Player 2013.xml 2018-07-28 13:50:49.304 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Marantz.xml 2018-07-28 13:50:49.304 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Denon AVR.xml 2018-07-28 13:50:49.305 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony PlayStation 4.xml 2018-07-28 13:50:49.305 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Blu-ray Player 2016.xml 2018-07-28 13:50:49.306 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Blu-ray Player.xml 2018-07-28 13:50:49.307 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Dish Hopper-Joey.xml 2018-07-28 13:50:49.307 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Linksys DMA2100.xml 2018-07-28 13:50:49.308 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Panasonic Viera.xml 2018-07-28 13:50:49.308 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Popcorn Hour.xml 2018-07-28 13:50:49.309 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/LG Smart TV.xml 2018-07-28 13:50:49.309 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Blu-ray Player 2015.xml 2018-07-28 13:50:49.310 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Bravia (2010).xml 2018-07-28 13:50:49.311 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/WDTV Live.xml 2018-07-28 13:50:49.311 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Bravia (2011).xml 2018-07-28 13:50:49.312 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Default.xml 2018-07-28 13:50:49.312 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Samsung Smart TV.xml 2018-07-28 13:50:49.313 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sharp Smart TV.xml 2018-07-28 13:50:49.314 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Xbox One.xml 2018-07-28 13:50:49.315 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna/system/Sony Blu-ray Player 2014.xml 2018-07-28 13:50:49.316 Debug XmlSerializer: Deserializing file /var/lib/emby/config/dlna.xml 2018-07-28 13:50:49.414 Info App: Entry point completed: Emby.Dlna.Main.DlnaEntryPoint. Duration: 0.2284628 seconds 2018-07-28 13:50:49.414 Info App: Starting entry point Emby.Server.Connect.ConnectEntryPoint 2018-07-28 13:50:49.416 Info App: Loading data from /var/lib/emby/data/connect.txt 2018-07-28 13:50:49.424 Info App: Loading data from /var/lib/emby/data/wan.dat 2018-07-28 13:50:49.432 Info App: Entry point completed: Emby.Server.Connect.ConnectEntryPoint. Duration: 0.0178785 seconds 2018-07-28 13:50:49.432 Info App: Core startup complete 2018-07-28 13:50:49.432 Info App: Post-init migrations complete 2018-07-28 13:50:49.432 Info App: Starting entry point Emby.Security.PluginSecurityManager 2018-07-28 13:50:49.432 Info App: Entry point completed: Emby.Security.PluginSecurityManager. Duration: 4.03E-05 seconds 2018-07-28 13:50:49.432 Info App: Starting entry point Emby.Server.CinemaMode.IntrosEntryPoint 2018-07-28 13:50:49.433 Info App: Entry point completed: Emby.Server.CinemaMode.IntrosEntryPoint. Duration: 0.0004143 seconds 2018-07-28 13:50:49.433 Info App: Starting entry point Emby.Security.PluginSecurityManager 2018-07-28 13:50:49.433 Info App: Entry point completed: Emby.Security.PluginSecurityManager. Duration: 4.05E-05 seconds 2018-07-28 13:50:49.433 Info App: Starting entry point Emby.Security.PluginSecurityManager 2018-07-28 13:50:49.433 Info App: Entry point completed: Emby.Security.PluginSecurityManager. Duration: 5.61E-05 seconds 2018-07-28 13:50:49.433 Info App: Starting entry point MBBackup.ServerEntryPoint 2018-07-28 13:50:49.433 Info App: Entry point completed: MBBackup.ServerEntryPoint. Duration: 3.18E-05 seconds 2018-07-28 13:50:49.433 Info App: Starting entry point Lastfm.ServerEntryPoint 2018-07-28 13:50:49.434 Info App: Entry point completed: Lastfm.ServerEntryPoint. Duration: 0.0007245 seconds 2018-07-28 13:50:49.434 Info App: Starting entry point AutoBoxSets.ServerEntryPoint 2018-07-28 13:50:49.436 Debug XmlSerializer: Deserializing file /var/lib/emby/plugins/configurations/AutoBoxSets.xml 2018-07-28 13:50:49.444 Info App: Entry point completed: AutoBoxSets.ServerEntryPoint. Duration: 0.0106408 seconds 2018-07-28 13:50:49.444 Info App: Starting entry point MediaBrowser.Api.ApiEntryPoint 2018-07-28 13:50:49.445 Info App: Entry point completed: MediaBrowser.Api.ApiEntryPoint. Duration: 0.00014 seconds 2018-07-28 13:50:49.445 Info App: Starting entry point Emby.Server.Implementations.News.NewsEntryPoint 2018-07-28 13:50:49.445 Info App: Entry point completed: Emby.Server.Implementations.News.NewsEntryPoint. Duration: 0.0003496 seconds 2018-07-28 13:50:49.445 Info App: Starting entry point Emby.Server.Implementations.LiveTv.EmbyTV.EntryPoint 2018-07-28 13:50:49.449 Info App: Loading live tv data from /var/lib/emby/data/livetv/timers 2018-07-28 13:50:49.459 Debug XmlSerializer: Deserializing file /var/lib/emby/config/livetv.xml 2018-07-28 13:50:49.533 Debug App: Ping test result to http://192.168.1.53:8096/system/ping. Success: True 2018-07-28 13:50:49.536 Debug App: Ping test result to http://192.168.1.53:8096/system/ping. Success: True 2018-07-28 13:50:49.537 Info Dlna: Registering publisher for urn:schemas-upnp-org:device:MediaServer:1 on 192.168.1.53 2018-07-28 13:50:49.629 Debug XmlSerializer: Deserializing file /var/lib/emby/root/default/FILM/options.xml 2018-07-28 13:50:49.683 Debug XmlSerializer: Deserializing file /var/lib/emby/root/default/Collections/options.xml 2018-07-28 13:50:49.684 Debug XmlSerializer: Deserializing file /var/lib/emby/root/default/LIVE/options.xml 2018-07-28 13:50:49.684 Debug XmlSerializer: Deserializing file /var/lib/emby/root/default/AUDIOBOOKS/options.xml 2018-07-28 13:50:49.684 Debug XmlSerializer: Deserializing file /var/lib/emby/root/default/MUSIC/options.xml 2018-07-28 13:50:49.689 Debug XmlSerializer: Deserializing file /var/lib/emby/root/default/TELEVISION/options.xml 2018-07-28 13:50:49.691 Info App: Entry point completed: Emby.Server.Implementations.LiveTv.EmbyTV.EntryPoint. Duration: 0.246232 seconds 2018-07-28 13:50:49.691 Info App: Starting entry point Emby.Server.Implementations.Library.DeviceAccessEntryPoint 2018-07-28 13:50:49.692 Info App: Entry point completed: Emby.Server.Implementations.Library.DeviceAccessEntryPoint. Duration: 0.0004407 seconds 2018-07-28 13:50:49.692 Info App: Starting entry point Emby.Server.Implementations.IO.LibraryMonitorStartup 2018-07-28 13:50:49.721 Info App: Entry point completed: Emby.Server.Implementations.IO.LibraryMonitorStartup. Duration: 0.0293442 seconds 2018-07-28 13:50:49.726 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.AutomaticRestartEntryPoint 2018-07-28 13:50:49.727 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.AutomaticRestartEntryPoint. Duration: 0.0009701 seconds 2018-07-28 13:50:49.727 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.ExternalPortForwarding 2018-07-28 13:50:49.728 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.ExternalPortForwarding. Duration: 0.00087 seconds 2018-07-28 13:50:49.728 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.KeepServerAwake 2018-07-28 13:50:49.728 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.KeepServerAwake. Duration: 0.0004245 seconds 2018-07-28 13:50:49.728 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.LibraryChangedNotifier 2018-07-28 13:50:49.730 Info LibraryMonitor: Watching directory /media/plex/MEDIA 2/MEDIA/MUSIC/LIVE 2018-07-28 13:50:49.730 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.LibraryChangedNotifier. Duration: 0.0021577 seconds 2018-07-28 13:50:49.730 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.RecordingNotifier 2018-07-28 13:50:49.732 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.RecordingNotifier. Duration: 0.0014267 seconds 2018-07-28 13:50:49.732 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.ServerEventNotifier 2018-07-28 13:50:49.735 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.ServerEventNotifier. Duration: 0.0030831 seconds 2018-07-28 13:50:49.735 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.StartupWizard 2018-07-28 13:50:49.736 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.StartupWizard. Duration: 0.0009777 seconds 2018-07-28 13:50:49.736 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.SystemEvents 2018-07-28 13:50:49.737 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.SystemEvents. Duration: 0.000376 seconds 2018-07-28 13:50:49.737 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.UdpServerEntryPoint 2018-07-28 13:50:49.739 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.UdpServerEntryPoint. Duration: 0.0021698 seconds 2018-07-28 13:50:49.739 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.UsageEntryPoint 2018-07-28 13:50:49.740 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.UsageEntryPoint. Duration: 0.0008534 seconds 2018-07-28 13:50:49.740 Info App: Starting entry point Emby.Server.Implementations.EntryPoints.UserDataChangeNotifier 2018-07-28 13:50:49.740 Info App: Entry point completed: Emby.Server.Implementations.EntryPoints.UserDataChangeNotifier. Duration: 0.0001533 seconds 2018-07-28 13:50:49.740 Info App: Starting entry point Emby.Server.Implementations.Devices.DeviceManagerEntryPoint 2018-07-28 13:50:49.741 Info App: Entry point completed: Emby.Server.Implementations.Devices.DeviceManagerEntryPoint. Duration: 0.0011762 seconds 2018-07-28 13:50:49.741 Info App: Starting entry point Emby.Server.Implementations.Collections.CollectionManagerEntryPoint 2018-07-28 13:50:49.742 Info App: Entry point completed: Emby.Server.Implementations.Collections.CollectionManagerEntryPoint. Duration: 0.0012759 seconds 2018-07-28 13:50:49.742 Info App: Starting entry point Emby.Server.Implementations.Activity.ActivityLogEntryPoint 2018-07-28 13:50:49.746 Info App: Entry point completed: Emby.Server.Implementations.Activity.ActivityLogEntryPoint. Duration: 0.0032054 seconds 2018-07-28 13:50:49.746 Info App: Starting entry point Emby.Server.MediaEncoding.Api.ApiEntryPoint 2018-07-28 13:50:49.747 Info App: Entry point completed: Emby.Server.MediaEncoding.Api.ApiEntryPoint. Duration: 0.00097 seconds 2018-07-28 13:50:49.747 Info App: Starting entry point Emby.Notifications.Notifications 2018-07-28 13:50:49.747 Info App: Entry point completed: Emby.Notifications.Notifications. Duration: 0.0005609 seconds 2018-07-28 13:50:49.747 Info App: Starting entry point MediaBrowser.XbmcMetadata.EntryPoint 2018-07-28 13:50:49.747 Info App: Entry point completed: MediaBrowser.XbmcMetadata.EntryPoint. Duration: 0.0001676 seconds 2018-07-28 13:50:49.747 Info App: Starting entry point Emby.Security.PluginSecurityManager 2018-07-28 13:50:49.748 Info App: Entry point completed: Emby.Security.PluginSecurityManager. Duration: 5.13E-05 seconds 2018-07-28 13:50:49.748 Info App: Starting entry point Emby.Server.Sync.SyncManagerEntryPoint 2018-07-28 13:50:49.754 Info App: Sqlite version: 3.24.0 2018-07-28 13:50:49.754 Info App: Sqlite compiler options: COMPILER=gcc-6.3.0,ENABLE_COLUMN_METADATA,ENABLE_DBSTAT_VTAB,ENABLE_FTS3,ENABLE_FTS3_PARENTHESIS,ENABLE_FTS3_TOKENIZER,ENABLE_FTS5,ENABLE_JSON1,ENABLE_PREUPDATE_HOOK,ENABLE_RTREE,ENABLE_SESSION,ENABLE_UNLOCK_NOTIFY,ENABLE_UPDATE_DELETE_LIMIT,LIKE_DOESNT_MATCH_BLOBS,MAX_SCHEMA_RETRY=25,MAX_VARIABLE_NUMBER=250000,OMIT_LOOKASIDE,SECURE_DELETE,THREADSAFE=1 2018-07-28 13:50:49.755 Info App: Default journal_mode for /var/lib/emby/data/sync14.db is wal 2018-07-28 13:50:49.756 Info App: PRAGMA synchronous=1 2018-07-28 13:50:49.757 Info App: Entry point completed: Emby.Server.Sync.SyncManagerEntryPoint. Duration: 0.0097477 seconds 2018-07-28 13:50:49.757 Info App: Starting entry point Emby.Server.Sync.SyncNotificationEntryPoint 2018-07-28 13:50:49.759 Info App: Entry point completed: Emby.Server.Sync.SyncNotificationEntryPoint. Duration: 0.0014429 seconds 2018-07-28 13:50:49.759 Info App: All entry points have started 2018-07-28 13:50:49.862 Info LibraryMonitor: Watching directory /media/plex/MEDIA 1/MEDIA/TV SHOWS/720x265 2018-07-28 13:50:49.881 Info LibraryMonitor: Watching directory /media/plex/MEDIA 1/MEDIA/TV SHOWS/MIXED 2018-07-28 13:50:49.894 Info LibraryMonitor: Watching directory /media/plex/MEDIA 3/MEDIA/FILM/4K 2018-07-28 13:50:49.963 Info LibraryMonitor: Watching directory /media/plex/MEDIA 1/MEDIA/TV SHOWS/1080x265 2018-07-28 13:50:49.969 Info HttpClient: GET https://emby.media/community/index.php?/blog/rss/1-media-browser-developers-blog 2018-07-28 13:50:50.002 Info LibraryMonitor: Watching directory /media/plex/MEDIA 3/MEDIA/FILM/MIXED 2018-07-28 13:50:50.005 Info LibraryMonitor: Watching directory /media/plex/MEDIA 3/MEDIA/TV/4K 2018-07-28 13:50:50.008 Info LibraryMonitor: Watching directory /media/plex/MEDIA 3/MEDIA/TV/1080x265 2018-07-28 13:50:50.060 Info LibraryMonitor: Watching directory /media/plex/MEDIA 2/MEDIA/AUDIOBOOKS/ENGELSKA 2018-07-28 13:50:50.074 Info LibraryMonitor: Watching directory /media/plex/MEDIA 2/MEDIA/TV SHOWS/1080x265 2018-07-28 13:50:50.127 Info LibraryMonitor: Watching directory /media/plex/MEDIA 3/MEDIA/FILM/1080x265 2018-07-28 13:50:50.344 Info LibraryMonitor: Watching directory /media/plex/MEDIA 2/MEDIA/MUSIC/ARTISTS 2018-07-28 13:50:51.893 Info HttpServer: HTTP GET http://192.168.1.53:8096/web/strings/en-GB.json?v=1532778653047. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:51.893 Info HttpServer: HTTP GET http://192.168.1.53:8096/web/bower_components/emby-webcomponents/strings/en-gb.json?v=1532778653047. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:51.893 Info HttpServer: HTTP GET http://192.168.1.53:8096/web/favicon.ico. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:51.903 Debug HttpResultFactory: Transmit file /opt/emby-server/system/dashboard-ui/strings/en-GB.json 2018-07-28 13:50:51.903 Debug HttpResultFactory: Transmit file /opt/emby-server/system/dashboard-ui/favicon.ico 2018-07-28 13:50:51.903 Debug HttpResultFactory: Transmit file /opt/emby-server/system/dashboard-ui/bower_components/emby-webcomponents/strings/en-gb.json 2018-07-28 13:50:51.909 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 16ms. http://192.168.1.53:8096/web/favicon.ico 2018-07-28 13:50:51.909 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 19ms. http://192.168.1.53:8096/web/bower_components/emby-webcomponents/strings/en-gb.json?v=1532778653047 2018-07-28 13:50:51.909 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 20ms. http://192.168.1.53:8096/web/strings/en-GB.json?v=1532778653047 2018-07-28 13:50:51.914 Info TaskManager: StartupTrigger fired for task: Check for plugin updates 2018-07-28 13:50:51.916 Info TaskManager: StartupTrigger fired for task: Check for application updates 2018-07-28 13:50:51.916 Info TaskManager: Queueing task PluginUpdateTask 2018-07-28 13:50:51.916 Info TaskManager: Queueing task SystemUpdateTask 2018-07-28 13:50:51.941 Info TaskManager: Executing Check for plugin updates 2018-07-28 13:50:51.941 Info TaskManager: Executing Check for application updates 2018-07-28 13:50:51.951 Info HttpClient: GET https://www.mb3admin.com/admin/service/EmbyPackages.json 2018-07-28 13:50:52.023 Debug App: No application update available. 2018-07-28 13:50:52.024 Info TaskManager: Check for application updates Completed after 0 minute(s) and 0 seconds 2018-07-28 13:50:52.041 Info TaskManager: ExecuteQueuedTasks 2018-07-28 13:50:52.072 Debug XmlSerializer: Deserializing file /var/lib/emby/config/branding.xml 2018-07-28 13:50:52.187 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/system/info/public. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.201 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 14ms. http://192.168.1.53:8096/emby/system/info/public 2018-07-28 13:50:52.204 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/System/Info. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.316 Info App: App Activity: app: Emby Mobile, version: 3.6.0.2, deviceId: TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzY3LjAuMzM5Ni45OSBTYWZhcmkvNTM3LjM2fDE1MzI3Nzc0NDE5NjY1, deviceName: Chrome 2018-07-28 13:50:52.346 Debug XmlSerializer: Deserializing file /var/lib/emby/config/users/3e1877189f324bf39c09d62a15459328/config.xml 2018-07-28 13:50:52.400 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 196ms. http://192.168.1.53:8096/emby/System/Info 2018-07-28 13:50:52.406 Info HttpServer: HTTP POST http://192.168.1.53:8096/emby/Sessions/Capabilities/Full. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.408 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/Users/3e1877189f324bf39c09d62a15459328. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.408 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/DisplayPreferences/usersettings?userId=3e1877189f324bf39c09d62a15459328&client=emby. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.414 Info HttpServer: WS http://192.168.1.53:8096/embywebsocket?api_key=87f329c23e8e435eac062530dd41c169&deviceId=TW96aWxsYS81LjAgKFdpbmRvd3MgTlQgMTAuMDsgV2luNjQ7IHg2NCkgQXBwbGVXZWJLaXQvNTM3LjM2IChLSFRNTCwgbGlrZSBHZWNrbykgQ2hyb21lLzY3LjAuMzM5Ni45OSBTYWZhcmkvNTM3LjM2fDE1MzI3Nzc0NDE5NjY1. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.422 Debug HttpServer: Web socket connection allowed 2018-07-28 13:50:52.445 Debug SessionManager: Creating new WebSocketController 2018-07-28 13:50:52.472 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 64ms. http://192.168.1.53:8096/emby/DisplayPreferences/usersettings?userId=3e1877189f324bf39c09d62a15459328&client=emby 2018-07-28 13:50:52.477 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 69ms. http://192.168.1.53:8096/emby/Users/3e1877189f324bf39c09d62a15459328 2018-07-28 13:50:52.479 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/Users/3e1877189f324bf39c09d62a15459328. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.480 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 1ms. http://192.168.1.53:8096/emby/Users/3e1877189f324bf39c09d62a15459328 2018-07-28 13:50:52.482 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/Users/3e1877189f324bf39c09d62a15459328. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.484 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 1ms. http://192.168.1.53:8096/emby/Users/3e1877189f324bf39c09d62a15459328 2018-07-28 13:50:52.502 Info HttpServer: HTTP Response 204 to 192.168.1.61. Time: 97ms. http://192.168.1.53:8096/emby/Sessions/Capabilities/Full 2018-07-28 13:50:52.512 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/web/configurationpages?pageType=PluginConfiguration&EnableInMainMenu=true. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.515 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/Plugins. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.527 Info HttpClient: GET https://www.mb3admin.com/admin/service/EmbyPackages.json 2018-07-28 13:50:52.552 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 39ms. http://192.168.1.53:8096/emby/web/configurationpages?pageType=PluginConfiguration&EnableInMainMenu=true 2018-07-28 13:50:52.562 Info HttpServer: HTTP GET http://192.168.1.53:8096/web/css/images/logoblack.png. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:52.563 Info HttpServer: HTTP Response 304 to 192.168.1.61. Time: 1ms. http://192.168.1.53:8096/web/css/images/logoblack.png 2018-07-28 13:50:53.177 Info TaskManager: Check for plugin updates Completed after 0 minute(s) and 1 seconds 2018-07-28 13:50:53.178 Info TaskManager: ExecuteQueuedTasks 2018-07-28 13:50:53.776 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 1262ms (slow). http://192.168.1.53:8096/emby/Plugins 2018-07-28 13:50:53.780 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/web/configurationpages?pageType=PluginConfiguration. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:53.780 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 1ms. http://192.168.1.53:8096/emby/web/configurationpages?pageType=PluginConfiguration 2018-07-28 13:50:53.891 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/System/Configuration. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:53.891 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/System/Logs. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:53.917 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 26ms. http://192.168.1.53:8096/emby/System/Configuration 2018-07-28 13:50:53.919 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 29ms. http://192.168.1.53:8096/emby/System/Logs 2018-07-28 13:50:54.548 Debug Dlna: Begin Sending Alive Notifications For All Devices 2018-07-28 13:50:54.561 Debug Dlna: Sent alive notification MediaServer - b2136b5f44634897ad34c3300667d1cc - http://192.168.1.53:8096/dlna/b2136b5f44634897ad34c3300667d1cc/description.xml 2018-07-28 13:50:54.561 Debug Dlna: Sent alive notification MediaServer - b2136b5f44634897ad34c3300667d1cc - http://192.168.1.53:8096/dlna/b2136b5f44634897ad34c3300667d1cc/description.xml 2018-07-28 13:50:54.561 Debug Dlna: Sent alive notification MediaServer - b2136b5f44634897ad34c3300667d1cc - http://192.168.1.53:8096/dlna/b2136b5f44634897ad34c3300667d1cc/description.xml 2018-07-28 13:50:54.561 Debug Dlna: Sent alive notification ContentDirectory - b2136b5f44634897ad34c3300667d1cc 2018-07-28 13:50:54.561 Debug Dlna: Sent alive notification ContentDirectory - b2136b5f44634897ad34c3300667d1cc 2018-07-28 13:50:54.561 Debug Dlna: Sent alive notification ConnectionManager - b2136b5f44634897ad34c3300667d1cc 2018-07-28 13:50:54.561 Debug Dlna: Sent alive notification ConnectionManager - b2136b5f44634897ad34c3300667d1cc 2018-07-28 13:50:54.561 Debug Dlna: Completed Sending Alive Notifications For All Devices 2018-07-28 13:50:56.164 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/System/Logs/Log?name=unhandled_6f53c478-aabf-40e9-880a-85b041e3aad9.txt. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 2018-07-28 13:50:56.171 Debug HttpResultFactory: Transmit file /var/lib/emby/logs/unhandled_6f53c478-aabf-40e9-880a-85b041e3aad9.txt 2018-07-28 13:50:56.171 Info HttpServer: HTTP Response 200 to 192.168.1.61. Time: 9ms. http://192.168.1.53:8096/emby/System/Logs/Log?name=unhandled_6f53c478-aabf-40e9-880a-85b041e3aad9.txt 2018-07-28 13:50:58.201 Info HttpServer: HTTP GET http://192.168.1.53:8096/emby/System/Logs/Log?name=embyserver.txt. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/67.0.3396.99 Safari/537.36 Edited July 28, 2018 by Darkieth Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 28, 2018 Share Posted July 28, 2018 Hi there, can you please attach the complete emby server log? Thanks. Link to comment Share on other sites More sharing options...
Darkieth 0 Posted July 28, 2018 Author Share Posted July 28, 2018 (edited) Where do I find it? What I posted above was the most recent under Logs. Anyways the issue seem to have resolved itself as I haven't had a crash since making the post. Edited July 28, 2018 by Darkieth Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 28, 2018 Share Posted July 28, 2018 You already found it above. I just want to see entire log files rather than snippets. Thanks ! Link to comment Share on other sites More sharing options...
Darkieth 0 Posted July 28, 2018 Author Share Posted July 28, 2018 What was posted above was all the information in the most recent log file at the time. Anyways, issue resolved for now. Link to comment Share on other sites More sharing options...
10479 3 Posted July 28, 2018 Share Posted July 28, 2018 I was having the exact same issue, however, upon reading the logs, I was able to see that every time it happened for me, it was due to an error with TheAudioDB as shown below. I was able to duplicate it every single time. If I turn off TheAudioDB in the music library settings, no more crashes. You have to turn on the advanced settings in the music library to prevent TheAudioDB from grabbing art and all that stuff as well. 2018-07-28 11:36:13.298 Info TaskManager: Executing Scan media library 2018-07-28 11:36:13.298 Info HttpServer: HTTP Response 204 to 10.0.0.4. Time: 4ms. http://server:8096/emby/ScheduledTasks/Running/6330ee8fb4a957f33981f89aa78b030f 2018-07-28 11:36:13.306 Info HttpServer: HTTP GET http://server:8096/emby/ScheduledTasks?IsEnabled=true. UserAgent: Mozilla/5.0 (X11; Linux x86_64; rv:61.0) Gecko/20100101 Firefox/61.0 2018-07-28 11:36:13.307 Info LibraryMonitor: Stopping directory watching for path /mnt/media/music 2018-07-28 11:36:13.308 Info HttpServer: HTTP Response 200 to 10.0.0.4. Time: 3ms. http://server:8096/emby/ScheduledTasks?IsEnabled=true 2018-07-28 11:36:13.317 Info App: Validating media library 2018-07-28 11:36:15.748 Info HttpClient: GET http://www.theaudiodb.com/api/v1/json/49jhsf8248yfahka89724011/album-mb.php?i=6c9f8751-ed37-4513-b534-841da417cd39 2018-07-28 11:36:16.875 Error Main: UnhandledException *** Error Report *** Version: 3.5.0.0 Command line: /usr/lib/emby-server/EmbyServer.dll -programdata /var/lib/emby -ffmpeg /usr/bin/ffmpeg -ffprobe /usr/bin/ffprobe -restartexitcode 3 Operating system: Unix 4.17.9.1 64-Bit OS: True 64-Bit Process: True User Interactive: True Processor count: 24 Program data path: /var/lib/emby Application directory: /usr/lib/emby-server System.IO.IOException: Unable to read data from the transport connection: Connection reset by peer. ---> System.Net.Sockets.SocketException: Connection reset by peer --- End of inner exception stack trace --- at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error) at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.GetResult(Int16 token) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Net.Security.SslState.ThrowIfExceptional() at System.Net.Security.SslState.CheckThrow(Boolean authSuccessCheck, Boolean shutdownCheck) at System.Net.Security.SslState.CheckOldKeyDecryptedData(Memory`1 buffer) at System.Net.Security.SslState.HandleQueuedCallback(Object& queuedStateRequest) at System.Net.Security.SslState.FinishHandshakeRead(Int32 newState) at System.Net.Security.SslState.FinishHandshake(Exception e, AsyncProtocolRequest asyncRequest) at System.Net.Security.SslState.RehandshakeCompleteCallback(IAsyncResult result) at System.Net.LazyAsyncResult.Complete(IntPtr userToken) at System.Net.LazyAsyncResult.ProtectedInvokeCallback(Object result, IntPtr userToken) at System.Net.AsyncProtocolRequest.CompleteUserWithError(Exception e) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state) --- End of stack trace from previous location where exception was thrown --- at System.Threading.ThreadPoolWorkQueue.Dispatch() System.IO.IOException at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error) at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.GetResult(Int16 token) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Net.Security.SslState.ThrowIfExceptional() at System.Net.Security.SslState.CheckThrow(Boolean authSuccessCheck, Boolean shutdownCheck) at System.Net.Security.SslState.CheckOldKeyDecryptedData(Memory`1 buffer) at System.Net.Security.SslState.HandleQueuedCallback(Object& queuedStateRequest) at System.Net.Security.SslState.FinishHandshakeRead(Int32 newState) at System.Net.Security.SslState.FinishHandshake(Exception e, AsyncProtocolRequest asyncRequest) at System.Net.Security.SslState.RehandshakeCompleteCallback(IAsyncResult result) at System.Net.LazyAsyncResult.Complete(IntPtr userToken) at System.Net.LazyAsyncResult.ProtectedInvokeCallback(Object result, IntPtr userToken) at System.Net.AsyncProtocolRequest.CompleteUserWithError(Exception e) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state) --- End of stack trace from previous location where exception was thrown --- at System.Threading.ThreadPoolWorkQueue.Dispatch() InnerException: System.Net.Sockets.SocketException System.Net.Sockets.SocketException (104): Connection reset by peer Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 28, 2018 Share Posted July 28, 2018 Thanks for the info. Our audiodb urls are still http, and audiodb redirects automatically to https. I have pushed an update to change the urls to https. This will avoid the redirect and perhaps that will simplify the ssl workflow and resolve the issue. The docker container should get the update later this afternoon. If you could let me know if that has any impact that would be helpful. thanks. 1 Link to comment Share on other sites More sharing options...
xenu 10 Posted July 28, 2018 Share Posted July 28, 2018 I disabled AudioDB for my music library and this fixes the crash on scanning. I noticed when I manually click "refresh metadata" on an item from within my music library it still tries to fetch data from AudioDB which results in a server crash. - Is it possible to respect the metadata settings when manually refreshing metadata in a library? - Maybe handle errors (regarding metada) more graceful (i.e not crash the whole server). Thank you. Is there a way to configure the musicbrainz server url emby uses? Link to comment Share on other sites More sharing options...
jon@spoonamore.net 2 Posted July 28, 2018 Share Posted July 28, 2018 I'm on version 3.5.1.0 on Linux Mint 18.3. Still having the crashes like everyone else. I just removed my Music Library and the problem went away. I will try to add this Library back in a future version. Good luck fixing this issue. Link to comment Share on other sites More sharing options...
10479 3 Posted July 29, 2018 Share Posted July 29, 2018 (edited) I disabled AudioDB for my music library and this fixes the crash on scanning. I noticed when I manually click "refresh metadata" on an item from within my music library it still tries to fetch data from AudioDB which results in a server crash. You need to switch on the advanced tab in the music library and disable TheAudioDB for the other features like poster art. I'm on version 3.5.1.0 on Linux Mint 18.3. Still having the crashes like everyone else. I just removed my Music Library and the problem went away. I will try to add this Library back in a future version. Good luck fixing this issue. Just disable TheAudioDB all the way through the advanced menu for the time being and you can keep your music library going. Thanks for the info. Our audiodb urls are still http, and audiodb redirects automatically to https. I have pushed an update to change the urls to https. This will avoid the redirect and perhaps that will simplify the ssl workflow and resolve the issue. The docker container should get the update later this afternoon. If you could let me know if that has any impact that would be helpful. thanks. Mine is prebuilt via arch linux, but I'll try to keep an eye out for the changes. If they are fairly minimal, I can just make them myself locally and go for it. Edited July 29, 2018 by 10479 Link to comment Share on other sites More sharing options...
Johnny-V 0 Posted July 29, 2018 Share Posted July 29, 2018 Same Server Crashing problem. Disabling TheAudioDB does not help (I also disabled this in advanced). Manual metarefresh still crashes the server. Running Linux Ubuntu 16.04.5 LTS Server. Both versions 3.5.0.0 and 3.5.1.0 same problem. Regards, and Suc6 fixing. Link to comment Share on other sites More sharing options...
malo87 13 Posted July 29, 2018 Share Posted July 29, 2018 (edited) Same Server Crashing problem. Disabling TheAudioDB does not help (I also disabled this in advanced). Manual metarefresh still crashes the server. Running Linux Ubuntu 16.04.5 LTS Server. Both versions 3.5.0.0 and 3.5.1.0 same problem. Regards, and Suc6 fixing. I think it is not enough just disabling TheAudioDB. I have the same error for MusicBrainz as well Ubuntu Linux 18.04 Emby 3.6.0.2 2018-07-29 11:42:10.873 Info HttpClient: GET http://ws.audioscrobbler.com/2.0/?method=album.getInfo&artist=Paramore&album=Misery+Business+%5B7%22+Single%5D%2F7%22+Single&api_key=7b76553c3eb1d341d642755aecc40a33&format=json 2018-07-29 11:42:11.352 Info HttpClient: GET http://musicbrainz01.eastus2.cloudapp.azure.com:8080/ws/2/release/?query="Misery+Business+%5B7%22+Single%5D%2F7%22+Single" AND arid:728ea90d-279b-4201-a8c4-597830883150 2018-07-29 11:42:12.068 Error App: Error in MusicBrainz *** Error Report *** Version: 3.6.0.2 Command line: /opt/emby-server/system/EmbyServer.dll -programdata /var/lib/emby -ffmpeg /opt/emby-server/bin/ffmpeg -ffprobe /opt/emby-server/bin/ffprobe -restartexitcode 3 -updatepackage emby-server-deb_{version}_amd64.deb Operating system: Unix 4.15.0.23 64-Bit OS: True 64-Bit Process: True User Interactive: True Processor count: 4 Program data path: /var/lib/emby Application directory: /opt/emby-server/system MediaBrowser.Model.Net.HttpException: BadRequest at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsyncInternal(HttpRequestOptions options, String httpMethod) at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsync(HttpRequestOptions options, String httpMethod) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMusicBrainzResponse(String url, Boolean isSearch, Boolean forceMusicBrainzProper, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetReleaseResult(String albumName, String artistId, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMetadata(AlbumInfo id, CancellationToken cancellationToken) at MediaBrowser.Providers.Manager.MetadataService`2.ExecuteRemoteProviders(MetadataResult`1 temp, String logName, TIdType id, IEnumerable`1 providers, CancellationToken cancellationToken) MediaBrowser.Model.Net.HttpException at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsyncInternal(HttpRequestOptions options, String httpMethod) at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsync(HttpRequestOptions options, String httpMethod) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMusicBrainzResponse(String url, Boolean isSearch, Boolean forceMusicBrainzProper, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetReleaseResult(String albumName, String artistId, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMetadata(AlbumInfo id, CancellationToken cancellationToken) at MediaBrowser.Providers.Manager.MetadataService`2.ExecuteRemoteProviders(MetadataResult`1 temp, String logName, TIdType id, IEnumerable`1 providers, CancellationToken cancellationToken) Edited July 29, 2018 by malo87 Link to comment Share on other sites More sharing options...
10479 3 Posted July 29, 2018 Share Posted July 29, 2018 Same Server Crashing problem. Disabling TheAudioDB does not help (I also disabled this in advanced). Manual metarefresh still crashes the server. Running Linux Ubuntu 16.04.5 LTS Server. Both versions 3.5.0.0 and 3.5.1.0 same problem. Regards, and Suc6 fixing. Not that I'm the expert here, but if you have logs showing what happened, it would be great. I can personally attest to completely disabling all TheAudioDB services and instantly not crashing. I can also re-enable it and crash the server. I think it is not enough just disabling TheAudioDB. I have the same error for MusicBrainz as well Ubuntu Linux 18.04 Emby 3.6.0.2 2018-07-29 11:42:10.873 Info HttpClient: GET http://ws.audioscrobbler.com/2.0/?method=album.getInfo&artist=Paramore&album=Misery+Business+%5B7%22+Single%5D%2F7%22+Single&api_key=7b76553c3eb1d341d642755aecc40a33&format=json 2018-07-29 11:42:11.352 Info HttpClient: GET http://musicbrainz01.eastus2.cloudapp.azure.com:8080/ws/2/release/?query="Misery+Business+%5B7%22+Single%5D%2F7%22+Single" AND arid:728ea90d-279b-4201-a8c4-597830883150 2018-07-29 11:42:12.068 Error App: Error in MusicBrainz *** Error Report *** Version: 3.6.0.2 Command line: /opt/emby-server/system/EmbyServer.dll -programdata /var/lib/emby -ffmpeg /opt/emby-server/bin/ffmpeg -ffprobe /opt/emby-server/bin/ffprobe -restartexitcode 3 -updatepackage emby-server-deb_{version}_amd64.deb Operating system: Unix 4.15.0.23 64-Bit OS: True 64-Bit Process: True User Interactive: True Processor count: 4 Program data path: /var/lib/emby Application directory: /opt/emby-server/system MediaBrowser.Model.Net.HttpException: BadRequest at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsyncInternal(HttpRequestOptions options, String httpMethod) at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsync(HttpRequestOptions options, String httpMethod) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMusicBrainzResponse(String url, Boolean isSearch, Boolean forceMusicBrainzProper, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetReleaseResult(String albumName, String artistId, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMetadata(AlbumInfo id, CancellationToken cancellationToken) at MediaBrowser.Providers.Manager.MetadataService`2.ExecuteRemoteProviders(MetadataResult`1 temp, String logName, TIdType id, IEnumerable`1 providers, CancellationToken cancellationToken) MediaBrowser.Model.Net.HttpException at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsyncInternal(HttpRequestOptions options, String httpMethod) at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsync(HttpRequestOptions options, String httpMethod) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMusicBrainzResponse(String url, Boolean isSearch, Boolean forceMusicBrainzProper, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetReleaseResult(String albumName, String artistId, CancellationToken cancellationToken) at MediaBrowser.Providers.Music.MusicBrainzAlbumProvider.GetMetadata(AlbumInfo id, CancellationToken cancellationToken) at MediaBrowser.Providers.Manager.MetadataService`2.ExecuteRemoteProviders(MetadataResult`1 temp, String logName, TIdType id, IEnumerable`1 providers, CancellationToken cancellationToken) Did the server actually crash after that? Link to comment Share on other sites More sharing options...
malo87 13 Posted July 29, 2018 Share Posted July 29, 2018 for me it's fine for the moment after disabling MusicBrainz and TheAudioDB Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 29, 2018 Share Posted July 29, 2018 Thanks for the info. It appears to be related to AudioDb. We're looking into it. 1 Link to comment Share on other sites More sharing options...
sansoo22 11 Posted July 29, 2018 Share Posted July 29, 2018 My first crashing issue started with a corrupt video file which lead me to this post. Here is the log for that. libavutil 56. 14.100 / 56. 14.100 libavcodec 58. 18.100 / 58. 18.100 libavformat 58. 12.100 / 58. 12.100 libavdevice 58. 3.100 / 58. 3.100 libavfilter 7. 16.100 / 7. 16.100 libswscale 5. 1.100 / 5. 1.100 libswresample 3. 1.100 / 3. 1.100 libpostproc 55. 1.100 / 55. 1.100 [mov,mp4,m4a,3gp,3g2,mj2 @ 0x644b40] moov atom not found file:/media/Movies/Inside Job (2010)/Inside.Job.2010.720p.mp4: Invalid data found when processing input UnhandledException System.IO.IOException: Unable to read data from the transport connection: Connection reset by peer. ---> System.Net.Sockets.SocketException: Connection reset by peer --- End of inner exception stack trace --- at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error) at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.GetResult(Int16 token) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Net.Security.SslState.ThrowIfExceptional() at System.Net.Security.SslState.CheckThrow(Boolean authSuccessCheck, Boolean shutdownCheck) at System.Net.Security.SslState.CheckOldKeyDecryptedData(Memory`1 buffer) at System.Net.Security.SslState.HandleQueuedCallback(Object& queuedStateRequest) at System.Net.Security.SslState.FinishHandshakeRead(Int32 newState) at System.Net.Security.SslState.FinishHandshake(Exception e, AsyncProtocolRequest asyncRequest) at System.Net.Security.SslState.RehandshakeCompleteCallback(IAsyncResult result) at System.Net.LazyAsyncResult.Complete(IntPtr userToken) at System.Net.LazyAsyncResult.ProtectedInvokeCallback(Object result, IntPtr userToken) at System.Net.AsyncProtocolRequest.CompleteUserWithError(Exception e) at System.Net.FixedSizeReader.ReadPacketAsync(Stream transport, AsyncProtocolRequest request) at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state) --- End of stack trace from previous location where exception was thrown --- at System.Threading.ThreadPoolWorkQueue.Dispatch() System.IO.IOException Once I removed that file Emby restarted and then crashed again on a library scan but this time with no extra info in the log. I disabled TheAudioDB and MusicBrainz and all is working again. Not sure if the corrupted file is related at all but thought i would share just in case. Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 30, 2018 Share Posted July 30, 2018 Thanks for the info. We are actively working on it. Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 30, 2018 Share Posted July 30, 2018 Emby Server 3.5.2 is on it's way up and will remove the audiodb metadata provider to stop the crashing. We'll get it restored for 3.6. Thanks. 1 Link to comment Share on other sites More sharing options...
malo87 13 Posted July 30, 2018 Share Posted July 30, 2018 Emby Server 3.5.2 is on it's way up and will remove the audiodb metadata provider to stop the crashing. We'll get it restored for 3.6. Thanks. Today Emby crashed again. I wonder that I found a log entry for audiodb even if it is disabled for all libraries... Logfile is attached emby log.txt Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 30, 2018 Share Posted July 30, 2018 Well you're on the beta release. I won't be removing audio db from the beta because we want to chase down and solve the problem. If you've already disabled audiodb then you could be seeing the url in your log if an audio db url was already saved into your database. Link to comment Share on other sites More sharing options...
malo87 13 Posted July 30, 2018 Share Posted July 30, 2018 (edited) Well you're on the beta release. I won't be removing audio db from the beta because we want to chase down and solve the problem. If you've already disabled audiodb then you could be seeing the url in your log if an audio db url was already saved into your database. yes I already disabled it. So this means Emby is not fetching the resources like pictures and texts from audiodb itself, it just fetches the links to it. And every time I open e.g a artist page in Emby it loads the pictures from audiodb? I ask because the error doesn't occurs while scanning the media library this time, it was while trying to access a artist page Edited July 30, 2018 by malo87 Link to comment Share on other sites More sharing options...
The_Duke_Sr 1 Posted July 30, 2018 Share Posted July 30, 2018 Emby Server 3.5.2 is on it's way up and will remove the audiodb metadata provider to stop the crashing. We'll get it restored for 3.6. Thanks. Did a rescan on my music lubrary with 3.5.2 and NO crash! Thnx for the quick fix. 1 Link to comment Share on other sites More sharing options...
Luke 37052 Posted July 30, 2018 Share Posted July 30, 2018 Thanks for the feedback. Link to comment Share on other sites More sharing options...
malo87 13 Posted July 30, 2018 Share Posted July 30, 2018 on 3.6.0.2 BETA its also fine now. Had to remove the complete music library and add it again without audiodb and musicbrainz. Means for me right now just last.fm is active. Just disabling audiodb and musicbrainz and then performing a full library scan had also ended in a server crash Link to comment Share on other sites More sharing options...
jon@spoonamore.net 2 Posted July 30, 2018 Share Posted July 30, 2018 Did a rescan on my music lubrary with 3.5.2 and NO crash! Thnx for the quick fix. Same here. I deleted my Music Lib and re-added it after installing v3.5.2. No crashes now. Excellent!!!! Link to comment Share on other sites More sharing options...
Recommended Posts
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 accountSign in
Already have an account? Sign in here.
Sign In Now