Jump to content

Emby video freezes until server restart


Recommended Posts

Posted

The last couple of days I've been having an issue where video freezes for a few seconds, then starts playing again, then freezes again after either a few seconds or less than a second, and this keeps going.

Initially I thought it's a connectivity issue, or something with my storage, however, on all occasions the videos were fully cached on local storage (on two different storage volumes on different occasions this happened), and a speed test between home and server was fine.

The second time this happened, I just had a thought; I went into the Android Emby app, admin settings, and restarted the Emby server (the service, not the machine). After the restart, videos played fine immediately and there were no further issues.

I will make sure to grab some logs next time it happens (no laptops in the living room), but in the mean time, has that happened to anyone before? Could it be the Emby process crashed somehow (yes I know I need to loop at server stats when this is happening etc., just asking though)?

The server is a VPS with 10Gbps up/down, and my home connection is 900Mbps down.

Posted

Hi @Luke,

It happened again today, here are the logs. The freeze happened at 20:27. I let it try to play again, it resumed playing for less than half a second and froze again. Then I stopped playback and restarted the server. It did not happen again after that for the 2 hours I watched.

2025-01-31 20:25:18.364 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:25:28.364 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:25:28.367 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:25:38.367 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:25:38.371 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:25:48.372 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:25:48.376 Info Server: http/1.0 Response 204 to host1. Time: 4ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:25:58.377 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:25:58.385 Info Server: http/1.0 Response 204 to host1. Time: 7ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:26:08.383 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:26:08.386 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:26:18.385 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:26:18.388 Info Server: http/1.0 Response 204 to host1. Time: 4ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:26:28.389 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:26:28.394 Info Server: http/1.0 Response 204 to host1. Time: 5ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:26:38.395 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:26:38.399 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:26:48.399 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:26:48.402 Info Server: http/1.0 Response 204 to host1. Time: 4ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:26:58.402 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:26:58.406 Info Server: http/1.0 Response 204 to host1. Time: 4ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:27:08.408 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:27:08.411 Info Server: http/1.0 Response 204 to host1. Time: 4ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:27:18.411 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:27:18.414 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:27:28.414 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Progress. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:27:28.417 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Progress
2025-01-31 20:27:33.885 Info Server: http/1.0 Response 404 to host1. Time: 0ms. GET http://host2/emby/embywebsocket?api_key=x_secret2_x&deviceId=0588b8e924950bcd
2025-01-31 20:27:34.656 Info Server: http/1.0 Response 206 to host1. Time: 537947ms. GET http://host2/emby/videos/154283/original.mkv?DeviceId=0588b8e924950bcd&MediaSourceId=3025ef7b34a0b576478c83ef8fa3ec1e&PlaySessionId=118998dbe4854fd1889b1e23ae0a45fc&api_key=x_secret2_x
2025-01-31 20:27:34.671 Info Server: http/1.0 POST http://host2/emby/Sessions/Playing/Stopped. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:27:34.672 Info SessionManager: Playback stopped reported by app AndroidTv 2.1.23g on Estia! playing The Pitt - S1, Ep5 - 11:00 A.M.. Stopped at 516583 ms. PlaySessionId: 118998dbe4854fd1889b1e23ae0a45fc
2025-01-31 20:27:34.674 Info SessionManager: Removing playSession 118998dbe4854fd1889b1e23ae0a45fc from session 737b62c49abfa2195f61fcc56b4f37be
2025-01-31 20:27:34.674 Info PlaybackReporting - EventMonitorEntryPoint: _sessionManager_PlaybackStop : Entered
2025-01-31 20:27:34.674 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Playing/Stopped
2025-01-31 20:27:34.678 Info PlaybackReporting - EventMonitorEntryPoint: Saving final duration for Item : 0588b8e924950bcd|7ce565e2d7dd4b50a218beaba41513f3|154283|DirectStream
2025-01-31 20:27:34.681 Info PlaybackReporting - EventMonitorEntryPoint: Removing Old Key from playback_trackers : 0588b8e924950bcd|7ce565e2d7dd4b50a218beaba41513f3|154283|DirectStream
2025-01-31 20:27:35.184 Info Server: http/1.0 POST http://host2/emby/Items/154283/PlaybackInfo?format=json. Source Ip: host1, UserAgent: Dalvik/2.1.0 (Linux; U; Android 11; SHIELD Android TV Build/RQ1A.210105.003)
2025-01-31 20:27:35.189 Info App: User policy for cronidis. EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
2025-01-31 20:27:35.190 Info App: User policy for cronidis. EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
2025-01-31 20:27:35.193 Info Server: http/1.0 Response 200 to host1. Time: 10ms. POST http://host2/emby/Items/154283/PlaybackInfo?format=json
2025-01-31 20:27:43.517 Info Server: http/1.0 POST http://host2/emby/Sync/data. Source Ip: host1, UserAgent: okhttp/4.12.0
2025-01-31 20:27:43.530 Info Server: http/1.0 Response 200 to host1. Time: 13ms. POST http://host2/emby/Sync/data
2025-01-31 20:27:43.557 Info Server: http/1.0 POST http://host2/emby/Sync/data. Source Ip: host1, UserAgent: okhttp/4.12.0
2025-01-31 20:27:43.558 Info Server: http/1.0 Response 200 to host1. Time: 1ms. POST http://host2/emby/Sync/data
2025-01-31 20:27:44.908 Info Server: http/1.0 POST http://host2/emby/Sessions/Capabilities/Full?X-Emby-Client=Emby for Android&X-Emby-Device-Name=SM-S928B&X-Emby-Device-Id=bf6c87e8b62835bc&X-Emby-Client-Version=3.4.34&X-Emby-Token=x_secret1_x&X-Emby-Language=en-gb&reqformat=json. Source Ip: host1, UserAgent: Mozilla/5.0 (Linux; Android 14; SM-S928B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.122 Mobile Safari/537.36
2025-01-31 20:27:44.910 Info Server: http/1.0 Response 204 to host1. Time: 3ms. POST http://host2/emby/Sessions/Capabilities/Full?X-Emby-Client=Emby for Android&X-Emby-Device-Name=SM-S928B&X-Emby-Device-Id=bf6c87e8b62835bc&X-Emby-Client-Version=3.4.34&X-Emby-Token=x_secret1_x&X-Emby-Language=en-gb&reqformat=json
2025-01-31 20:27:44.990 Info Server: http/1.0 Response 404 to host1. Time: 0ms. GET http://host2/embywebsocket?api_key=x_secret1_x&deviceId=bf6c87e8b62835bc
2025-01-31 20:27:45.145 Info App: Sqlite: 284 - automatic index on LastWatchedEpisodes(SeriesPresentationUniqueKey)
2025-01-31 20:27:45.799 Info HttpClient: GET https://image.tmdb.org/t/p/original/hvGWyyC8wER1I8ExSXNtFBs7Mgd.jpg
2025-01-31 20:28:16.698 Info Server: http/1.0 POST http://host2/emby/System/Restart?X-Emby-Client=Emby for Android&X-Emby-Device-Name=SM-S928B&X-Emby-Device-Id=bf6c87e8b62835bc&X-Emby-Client-Version=3.4.34&X-Emby-Token=x_secret1_x&X-Emby-Language=en-gb. Source Ip: host1, UserAgent: Mozilla/5.0 (Linux; Android 14; SM-S928B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.122 Mobile Safari/537.36
2025-01-31 20:28:16.701 Info Server: http/1.0 Response 204 to host1. Time: 4ms. POST http://host2/emby/System/Restart?X-Emby-Client=Emby for Android&X-Emby-Device-Name=SM-S928B&X-Emby-Device-Id=bf6c87e8b62835bc&X-Emby-Client-Version=3.4.34&X-Emby-Token=x_secret1_x&X-Emby-Language=en-gb
2025-01-31 20:28:16.712 Info App: Calling RestartInternal
2025-01-31 20:28:16.714 Info Main: AppHost_RestartRequested
2025-01-31 20:28:16.758 Info Server: Stopping HttpListener...
2025-01-31 20:28:16.782 Info Server: HttpListener stopped
2025-01-31 20:28:16.783 Info App: Disposing CoreAppHost
2025-01-31 20:28:16.784 Info App: Disposing LoopUtilEntryPoint
2025-01-31 20:28:16.785 Info App: Disposing SyncNotificationEntryPoint
2025-01-31 20:28:16.788 Info App: Disposing ConnectEntryPoint
2025-01-31 20:28:16.789 Info App: Disposing NotificationManagerEntryPoint
2025-01-31 20:28:16.789 Info App: Disposing EncodingManagerEntryPoint
2025-01-31 20:28:16.790 Info App: Disposing ActivityLogEntryPoint
2025-01-31 20:28:16.802 Info App: Disposing RecordingNotifier
2025-01-31 20:28:16.810 Info App: Disposing EntryPoint
2025-01-31 20:28:16.810 Info App: Disposing ChannelsEntryPoint
2025-01-31 20:28:16.810 Info App: Disposing UserDataChangeNotifier
2025-01-31 20:28:16.811 Info App: Disposing SystemEvents
2025-01-31 20:28:16.812 Info App: Disposing StartupWizard
2025-01-31 20:28:16.812 Info App: Disposing ServerEventNotifier
2025-01-31 20:28:16.815 Info App: Disposing LibraryChangedNotifier
2025-01-31 20:28:16.818 Info App: Disposing KeepServerAwake
2025-01-31 20:28:16.818 Info App: Disposing AutomaticRestartEntryPoint
2025-01-31 20:28:16.819 Info App: Disposing LibraryMonitorStartup
2025-01-31 20:28:16.819 Info App: Disposing DeviceAccessEntryPoint
2025-01-31 20:28:16.819 Info App: Disposing RemoteAddressEntryPoint
2025-01-31 20:28:16.819 Info App: Disposing PlaylistUpgradeEntryPoint
2025-01-31 20:28:16.819 Info App: Disposing UdpServerEntryPoint
2025-01-31 20:28:16.820 Info App: Disposing DlnaEntryPoint
2025-01-31 20:28:16.828 Info DLNA: Disposing PlayToManager
2025-01-31 20:28:16.834 Info App: Disposing EntryPoint
2025-01-31 20:28:16.836 Info App: Disposing ServerEntryPoint
2025-01-31 20:28:16.838 Info App: Disposing PluginStartup
2025-01-31 20:28:16.842 Info App: Disposing ExternalPortForwarding
2025-01-31 20:28:16.846 Info App: Disposing EventMonitorEntryPoint
2025-01-31 20:28:16.847 Info App: Disposing MigrationEntryPoint
2025-01-31 20:28:16.848 Info App: Disposing IntrosEntryPoint
2025-01-31 20:28:16.851 Info App: Disposing PluginSecurityManager
2025-01-31 20:28:16.851 Info App: Disposing EntryPoint
2025-01-31 20:28:16.852 Info App: Disposing StrmMounter
2025-01-31 20:28:16.852 Info App: Disposing BlurayMounter
2025-01-31 20:28:16.855 Info App: Disposing DvdMounter
2025-01-31 20:28:16.856 Info App: Disposing OpenSubtitleDownloader
2025-01-31 20:28:16.861 Info App: Disposing HauppaugeTunerWindows
2025-01-31 20:28:16.861 Info App: Disposing ActivityLogWebSocketListener
2025-01-31 20:28:16.864 Info App: Disposing SessionWebSocketListener
2025-01-31 20:28:16.865 Info App: Disposing ScheduledTasksWebSocketListener
2025-01-31 20:28:16.866 Info App: Disposing SessionInfoWebSocketListener
2025-01-31 20:28:16.868 Info App: Disposing SessionInfosWebSocketListener
2025-01-31 20:28:16.869 Info App: Disposing SessionEventsWebSocketListener
2025-01-31 20:28:16.871 Info App: Disposing UIPagesManager
2025-01-31 20:28:16.874 Info App: Disposing EncodingManager
2025-01-31 20:28:16.876 Info App: Disposing ActivityRepository
2025-01-31 20:28:16.879 Info ActivityRepository: DisposeConnection
2025-01-31 20:28:16.881 Info ActivityRepository: PRAGMA analysis_limit=400;PRAGMA optimize
2025-01-31 20:28:16.883 Info ActivityRepository: Closing sqlite connection
2025-01-31 20:28:16.888 Info App: Disposing MediaEncoder
2025-01-31 20:28:16.888 Info App: Disposing SsdpDevicePublisher
2025-01-31 20:28:16.920 Info App: Disposing SsdpCommunicationsServer
2025-01-31 20:28:16.926 Info App: SsdpCommunicationsServer Disposing 4 sendSockets
2025-01-31 20:28:16.926 Info App: SsdpCommunicationsServer disposing sendSocket from 0.0.0.0:1900
2025-01-31 20:28:16.926 Info App: SsdpCommunicationsServer disposing sendSocket from 0.0.0.0:50231
2025-01-31 20:28:16.926 Info App: SsdpCommunicationsServer disposing sendSocket from 127.0.0.1:40435
2025-01-31 20:28:16.926 Info App: SsdpCommunicationsServer disposing sendSocket from 94.130.171.240:59800
2025-01-31 20:28:16.926 Info App: Disposing NotificationManager
2025-01-31 20:28:16.931 Info App: Disposing LiveTvManager
2025-01-31 20:28:16.931 Info App: Disposing SessionManager
2025-01-31 20:28:16.933 Info App: Disposing ProviderManager
2025-01-31 20:28:16.934 Info App: Disposing MediaSourceManager
2025-01-31 20:28:16.936 Info App: Disposing ImageProcessor
2025-01-31 20:28:16.937 Info App: Disposing ProcessManager
2025-01-31 20:28:16.943 Info App: Disposing HttpListenerHost
2025-01-31 20:28:16.943 Info Server: Stopping HttpListener...
2025-01-31 20:28:16.943 Info Server: HttpListener stopped
2025-01-31 20:28:16.943 Info App: Disposing LibraryMonitor
2025-01-31 20:28:16.948 Info App: Disposing AuthenticationRepository
2025-01-31 20:28:16.948 Info AuthenticationRepository: DisposeConnection
2025-01-31 20:28:16.949 Info AuthenticationRepository: PRAGMA analysis_limit=400;PRAGMA optimize
2025-01-31 20:28:16.949 Info AuthenticationRepository: Closing sqlite connection
2025-01-31 20:28:16.952 Info App: Disposing SqliteUserDataRepository
2025-01-31 20:28:16.952 Info SqliteUserDataRepository: DisposeConnection
2025-01-31 20:28:16.952 Info App: Disposing SqliteItemRepository
2025-01-31 20:28:16.952 Info SqliteItemRepository: DisposeConnection
2025-01-31 20:28:16.953 Info SqliteItemRepository: PRAGMA analysis_limit=400;PRAGMA optimize
2025-01-31 20:28:16.972 Info SqliteItemRepository: Closing sqlite connection
2025-01-31 20:28:17.013 Info App: Disposing SqliteDisplayPreferencesRepository
2025-01-31 20:28:17.013 Info SqliteDisplayPreferencesRepository: DisposeConnection
2025-01-31 20:28:17.014 Info SqliteDisplayPreferencesRepository: PRAGMA analysis_limit=400;PRAGMA optimize
2025-01-31 20:28:17.014 Info SqliteDisplayPreferencesRepository: Closing sqlite connection
2025-01-31 20:28:17.015 Info App: Disposing SqliteUserRepository
2025-01-31 20:28:17.015 Info SqliteUserRepository: DisposeConnection
2025-01-31 20:28:17.015 Info SqliteUserRepository: PRAGMA analysis_limit=400;PRAGMA optimize
2025-01-31 20:28:17.015 Info SqliteUserRepository: Closing sqlite connection
2025-01-31 20:28:17.019 Info App: Disposing InstallationManager
2025-01-31 20:28:17.021 Info App: Disposing TaskManager
2025-01-31 20:28:17.024 Info App: Disposing MediaMountManager
2025-01-31 20:28:17.025 Info App: Dispose complete

 

  • 2 weeks later...
Posted

Hi,

This is (I think) what happens to me (using LG TV as well) sometimes, just out of the blue. I have checked logs previously and seen the same pattern, like:

Time:
3ms
3ms
4ms
3ms
7ms
3ms
4ms
4ms
197891ms

However, playback eventually resumes, but I need to wait 4-6-8 minutes. What I do to work it around is I hit the back arrow on the remote control, so I jump back 10 seconds with the playback and by the time it reaches the point where it got stuck, it just plays fine. Not sure what it is, network or cache or server, but it happens 1-2 times a week sometimes nothing for a week or two, then it happens again. This has been happening for me in the last couple of months, always using the latest beta, which other than this seems to be working pretty well usually. Running my Emby server on a Synology DS220+ if that matters, DiskStation Manager (DSM) is a Linux-based operating system as I know. I do not really think it is connection\speed issue as kids usually watch cartoons in SD. Also, this is happening via direct play and with transcoding as well. And the other reason why I do not think it is the connection because using different laptops or phones on the same local network at home, it does not happen. It seems to be happening only on the LG TVs (on both of them that I have). It is a totally random also quite rare situation but it is still happening.

Hopefully, this info could be helpful, I do not have fresh logs and I cannot find the ones I gathered last time. As it is happening in quite rare cases, I did not feel the need to report it. I am still not 100% sure if it is not environmental, but I thought I just share my experience, the info I provided might be useful.
 

 

  • Like 1
Posted

Hey @Grivalszki, I have started using the dreaded Android app (as opposed to the Android TV app, which apparently and very unfortunately seems to be coming to an end), as I read somewhere that this problem appears with the Android TV app but not with the Android app.

Anyway, it has not happened since I switched to the Android app, but it's only been a couple of weeks, so more testing is needed.

Definitely not too happy if this is the solution as I like the Android TV app MUCH better in terms of UI and UX.

  • 2 weeks later...
Posted

Hi, what about the ui do you like better?

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...