Server Version#: 1.14.0.5470
Client Version#: Latest version of Plex on AppleTV
Just a short introduction:
So this weird thing happened…
A user was streaming (lets call it) file1.mkv from his AppleTV. Some time after the stream was finished Tautulli started spamming me with notifications that the user was changing his quality/transcode settings. I got around 5-10 notifications per second. I went and restarted the server, everything was fine.
Today he was playing file2.mkv when the same thing happened. And the weird thing was that I got notifications for file1.mkv, not the one he was playing. I looked into it closer and Plex was reporting the same thing, in other words, the problem is not with Tautulli, but I’m guessing Plex. It does not stop if the user stops playing. Plex is is locked in some kind of loop. Tho, removing his library rights fixed it after 4-5minutes. I can add that the user has his settings on match quality/direct stream.
The problem (I belive):
After some investigation through the Plex logs, it looks like the client spams the server with requests. Even tho the user is doing something completely different, like watching file2.mkv. Going through the logs is far beyond my knowledge, but this is what gets repeated, 5-10times per second.
I’m not sure what log files to add (given that there are 91), but this is what I find in a few of them (I’ve censored out private information).
From Plex Media Server1.log
DEBUG - Request: [USER-IP:xxxxx (WAN)] GET /:/timeline?bufferedTime=7&duration=8073152&key=%2Flibrary%2Fmetadata%2F4911&location=wan&playQueueItemID=3316&playbackTime=1727038&ratingKey=4911&state=paused&time=6244400 (26 live) TLS GZIP Signed-in Token ()
DEBUG - Completed: [USER-IP:xxxxx] 401 GET /:/timeline?bufferedTime=7&duration=8073152&key=%2Flibrary%2Fmetadata%2F4911&location=wan&playQueueItemID=3316&playbackTime=1727038&ratingKey=4911&state=paused&time=6244400 (26 live) TLS GZIP 0ms 338 bytes (pipelined: 6150)
DEBUG - Auth: authenticated user 1 as OWNER-NAME
DEBUG - Request: [LOCAL-IP:xxxxx (Subnet)] GET /status/sessions (25 live) TLS Signed-in Token (OWNER-NAME)
DEBUG - [Now] Adding 3 sessions.
DEBUG - Completed: [LOCAL-IP:xxxxx] 200 GET /status/sessions (25 live) TLS 3ms 36325 bytes (pipelined: 1)
DEBUG - Auth: authenticating user as guest
From Plex Media Server2.log
DEBUG - Play progress on ID 'file1.mkv' - got played 6117867 ms by account USER-ID!
DEBUG - [Now] User is USER-NAME (ID: USER-ID)
DEBUG - [Now] Device is tvOS (Apple TV).
DEBUG - [Now] Profile is tvOS
DEBUG - [Now] Updated play state for /library/metadata/ID.
DEBUG - Statistics: (6568C028-97BF-482E-B3C4-405A6FB785A1) Reporting active playback in state 1 of type 1 (scrobble: 0) for account USER-ID
DEBUG - Completed: [USER-IP:xxxxx] 200 GET /:/timeline?bufferedTime=32&duration=8073152&key=%2Flibrary%2Fmetadata%2FID&location=wan&playQueueItemID=3316&playbackTime=1727038&ratingKey=ID&state=paused&time=6117867 (21 live) TLS GZIP 8ms 750 bytes (pipelined: 2352)
DEBUG - Auth: authenticated user 1 as OWNER-NAME
DEBUG - Request: [LOCAL-IP:xxxxx (Subnet)] GET /status/sessions (20 live) TLS Signed-in Token (OWNER-NAME)
DEBUG - [Now] Adding 3 sessions.
DEBUG - Completed: [LOCAL-IP:xxxxx] 200 GET /status/sessions (20 live) TLS 4ms 36363 bytes (pipelined: 1)
DEBUG - Auth: authenticated user USER-ID as USER-NAME
DEBUG - Request: [USER-IP:xxxxxx (WAN)] GET /:/timeline?bufferedTime=32&duration=8073152&key=%2Flibrary%2Fmetadata%2FID&location=wan&playQueueItemID=3316&playbackTime=1727038&ratingKey=ID&state=paused&time=6117901 (20 live) TLS GZIP Signed-in Token (USER-NAME)
Any clue what’s happening here?
