Failed to download subtitle

General Discussions
126

PMS v1.41.0.8992 on Synology DSM 7 fully updated.
Plex Web v4.136.1

image
image1028Ɨ329 51.2 KB

Plex Media Server Logs_2024-09-21_20-56-32.zip (4.2 MB)

Please help.

1 Like
127

I am also having this issue now.

128

I had this issue start for me a month ago of so. It worked flawlessly before that for four years. This is a real pain as my wife is from Brazil and the subtitles are a big help for her enjoyment.

129

I use the download subtitles feature every day. As of yesterday this problem has started. No matter what subtitle I pick, it fails to download and gives an error message.

130

Same for me, no subs works it just fails no matter what u choseā€¦ dont know how fix this

131

Did it just start for you a few days ago?

132

yes noticed some days ago. app is fully updated computer also.

133

Just noticed I am having this problem now too. Started recently in the last week or two.

server version: 1.41.3.9314 on docker
web version: 4.141.0

image
image742Ɨ539 11.2 KB

edit 2024-12-28: started working again with no changes.

134

Hello,

in the logs Iā€™m getting the following error.

Server-version 1.41.3.9314-a0bfb8370
Web Version 4.141.0

Dec 28, 2024 22:38:09.098 [140418072021816] DEBUG - Request: [192.168.1.35:51690 (Subnet)] OPTIONS /library/metadata/7503/subtitles?key=%2Flibrary%2Fstreams%2F41897&codec=srt&language=eng&hearingImpaired=0&forced=0&providerTitle=OpenSubtitles (5 live) #1b2 TLS GZIP Signed-in Token ()
Dec 28, 2024 22:38:09.098 [140418125400888] DEBUG - Completed: [192.168.1.35:51690] 200 OPTIONS /library/metadata/7503/subtitles?key=%2Flibrary%2Fstreams%2F41897&codec=srt&language=eng&hearingImpaired=0&forced=0&providerTitle=OpenSubtitles (5 live) #1b2 TLS GZIP 0ms 364 bytes (pipelined: 1)
Dec 28, 2024 22:38:09.101 [140418072021816] DEBUG - Request: [192.168.1.35:51690 (Subnet)] PUT /library/metadata/7503/subtitles?key=%2Flibrary%2Fstreams%2F41897&codec=srt&language=eng&hearingImpaired=0&forced=0&providerTitle=OpenSubtitles (5 live) #1be TLS GZIP Signed-in Token (plexuser) (mycomputer)
Dec 28, 2024 22:38:09.116 [140418072021816] DEBUG - [Req#1be] Activity: registered new activity e2f94286-c384-42af-8587-1fafd237c472 - "Downloading Subtitle"
Dec 28, 2024 22:38:09.117 [140418093366072] DEBUG - [Req#1be] Downloading subtitle from https://metadata.provider.plex.tv/library/streams/3085702?X-Plex-Api-Token=xxxxxxxxxxxxxxxxxxxx
Dec 28, 2024 22:38:09.118 [140418127510328] DEBUG - Completed: [192.168.1.35:51690] 200 PUT /library/metadata/7503/subtitles?key=%2Flibrary%2Fstreams%2F41897&codec=srt&language=eng&hearingImpaired=0&forced=0&providerTitle=OpenSubtitles (5 live) #1be TLS GZIP 17ms 411 bytes (pipelined: 2)
Dec 28, 2024 22:38:09.176 [140418093366072] DEBUG - [Req#1be] Got a subtitle of 99 bytes.
Dec 28, 2024 22:38:09.177 [140418093366072] DEBUG - [Req#1be] Activity: Ended activity e2f94286-c384-42af-8587-1fafd237c472.
Dec 28, 2024 22:38:11.202 [140418072021816] DEBUG - [Req#1bd] [PlexRelay] Transferred: sent 22012, received 7144 bytes, in 321.1 seconds
Dec 28, 2024 22:38:11.204 [140418072021816] DEBUG - [Req#1cc] [PlexRelay] Bytes per second: sent 68.6, received 22.2
Dec 28, 2024 22:38:11.206 [140418137873208] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Relay' exit code for process 2414 is 255 (failure)

Looking at the server side everything seems to be in order.

  • Restarted the plexmediaserver ā€œservice plexmediaserver restartā€ no issues found.
  • Checked all DNS server in the network config all are resolving.

Any ideas?

135

Super annoying, canā€™t believe the original issue is over a year old now!

136

Started having this issue as of today aswell.

137

I believe this has something to do with either some kind of central rate limiting or other issue between plex and opensubtitles.
Iā€™m in GMT and I couldnā€™t get any subs in the evening yesterday. Itā€™s morning now, and it works. Iā€™ve also checked this two days ago and it was the same.
There is one log entry that says something like ā€œsubtitles downloaded (99 bytes received)ā€
but it probably returns an error message in the body instead.
I tried to do some troubleshooting but now everything works so canā€™t see the error.
Will try again in the evening when I expect the subtitles not working again.

Also I came across post about entering some opensubtitles credentials somewhere. I donā€™t think itā€™s still a thing with recent versions of Plex.

When you get the error, try finding the entry in the log:

Downloading subtitle from https://metadata.provider.plex.tv/library/streams/3085702?X-Plex-Api-Token=xxxxxxxxxxxxxxxxxxxx

Google how to get you Plex API token and try that request in the browser.

Notice that in order to download a subtitle, the request goes through plex servers (metadata.provider.plex.tv). I believe thatā€™s where the bottleneck is.

138

Iā€™ve been getting a lot of these errors with subtitles as wellā€¦ :neutral_face:

139

Adding another report for this issue. It seems to affect me intermittently. This time I got frustrated and did some digging. I wasnā€™t able to to find a solution but I did fint this in the OpenSubtitles agent log.

Running PMS Version 1.41.3.9314 on a QNAP NAS, connecting with Plex windows app and Plex google tv app.

2024-06-13 19:00:24,017 (7f56650a0808) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 5070ad4 (Fri Nov 25 06:22:39 UTC 2022)
2024-06-13 19:00:24,018 (7f56650a0808) :  DEBUG (core:361) - Using the standard policy
2024-06-13 19:00:24,018 (7f56650a0808) :  DEBUG (core:450) - Starting runtime component.
2024-06-13 19:00:24,019 (7f56650a0808) :  DEBUG (core:450) - Starting caching component.
2024-06-13 19:00:24,019 (7f56650a0808) :  DEBUG (core:450) - Starting data component.
2024-06-13 19:00:24,019 (7f56650a0808) :  DEBUG (core:450) - Starting networking component.
2024-06-13 19:00:24,020 (7f56650a0808) :  DEBUG (networking:265) - No cookie jar found
2024-06-13 19:00:24,035 (7f56650a0808) :  DEBUG (networking:428) - Setting the default network timeout to 20.0
2024-06-13 19:00:24,036 (7f56650a0808) :  DEBUG (core:450) - Starting localization component.
2024-06-13 19:00:24,036 (7f56650a0808) :  INFO (localization:409) - Setting the default locale to en-us
2024-06-13 19:00:24,036 (7f56650a0808) :  DEBUG (localization:427) - Loaded en strings
2024-06-13 19:00:24,036 (7f56650a0808) :  DEBUG (core:450) - Starting messaging component.
2024-06-13 19:00:24,037 (7f56650a0808) :  DEBUG (core:450) - Starting debugging component.
2024-06-13 19:00:24,037 (7f56650a0808) :  DEBUG (core:450) - Starting services component.
2024-06-13 19:00:24,037 (7f56650a0808) :  DEBUG (core:450) - Starting myplex component.
2024-06-13 19:00:24,037 (7f5661cceb38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.opensubtitles'
2024-06-13 19:00:24,037 (7f56650a0808) :  DEBUG (core:450) - Starting notifications component.
2024-06-13 19:00:24,173 (7f56650a0808) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.opensubtitles in namespace 'metadata'
2024-06-13 19:00:24,179 (7f56650a0808) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2024-06-13 19:00:24,185 (7f56650a0808) :  ERROR (networking:196) - Error opening URL 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2024-06-13 19:00:24,187 (7f56650a0808) :  CRITICAL (runtime:1299) - Exception getting hosted resource hashes (most recent call last):
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-5070ad484/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/runtime.py", line 1293, in get_resource_hashes
    json = self._core.networking.http_request("http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes", timeout=10).content
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-5070ad484/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 242, in content
    return self.__str__()
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-5070ad484/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 220, in __str__
    self.load()
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-5070ad484/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 158, in load
    f = self._opener.open(req, timeout=self._timeout)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Python/python27.zip/urllib2.py", line 435, in open
    response = meth(req, response)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Python/python27.zip/urllib2.py", line 548, in http_response
    'http', request, response, code, msg, hdrs)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Python/python27.zip/urllib2.py", line 473, in error
    return self._call_chain(*args)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Python/python27.zip/urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Python/python27.zip/urllib2.py", line 556, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 404: Not Found

2024-06-13 19:00:24,196 (7f5661aaab38) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2024-06-13 19:00:24,196 (7f56650a0808) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2024-06-13 19:00:24,197 (7f56650a0808) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2024-06-13 19:00:24,197 (7f5661aaab38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2024-06-13 19:00:24,197 (7f5661a1db38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400'
2024-06-13 19:00:24,198 (7f56650a0808) :  DEBUG (core:150) - Finished starting framework core
2024-06-13 19:00:24,199 (7f56650a0808) :  DEBUG (core:560) - Loading plug-in code
2024-06-13 19:00:24,250 (7f5661a1db38) :  DEBUG (core:538) - Machine identifier is 0a9d2c021ec3817e20e24d4e71376be39c6051cc
2024-06-13 19:00:24,261 (7f5661a1db38) :  DEBUG (core:539) - Server version is 1.30.0.6442-5070ad484
2024-06-13 19:00:24,262 (7f5661aaab38) :  DEBUG (services:362) - Loaded services
2024-06-13 19:00:24,275 (7f5661a40b38) :  DEBUG (services:438) - No shared code to load
2024-06-13 19:00:24,290 (7f56650a0808) :  DEBUG (core:566) - Finished loading plug-in code
2024-06-13 19:00:24,302 (7f56650a0808) :  DEBUG (agentkit:1132) - Creating new agent class called OpenSubtitlesAgentMovies
2024-06-13 19:00:24,302 (7f56650a0808) :  DEBUG (agentkit:937) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'OpenSubtitles.org'}]
2024-06-13 19:00:24,303 (7f56650a0808) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczMyCmNvbS5wbGV4YXBwLmFnZW50cy5vcGVuc3VidGl0bGVzczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjFzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMTcKT3BlblN1YnRpdGxlcy5vcmdzNApuYW1lMQpzNQpNb3ZpZTEKczIzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiMQpzMgp4bnIwCg__'
2024-06-13 19:00:24,309 (7f56650a0808) :  DEBUG (agentkit:1132) - Creating new agent class called OpenSubtitlesAgentTV
2024-06-13 19:00:24,310 (7f56650a0808) :  DEBUG (agentkit:937) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'OpenSubtitles.org'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb'], 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'OpenSubtitles.org'}]
2024-06-13 19:00:24,310 (7f56650a0808) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczMyCmNvbS5wbGV4YXBwLmFnZW50cy5vcGVuc3VidGl0bGVzczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjFzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMTcKT3BlblN1YnRpdGxlcy5vcmdzNApuYW1lMQpzNQpNb3ZpZTEKczIzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiMQpzMgp4bjEwCnI3CnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI4CnMxNApjb250cmlidXRlc190b3I5CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIwczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczE3Ck9wZW5TdWJ0aXRsZXMub3JnczQKbmFtZTEKczcKVFZfU2hvdzEKczI2CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiMQpzMgp4bnIwCg__'
2024-06-13 19:00:24,318 (7f56650a0808) :  INFO (datakit:118) - No default dictionary file
2024-06-13 19:00:24,319 (7f56650a0808) :  INFO (datakit:131) - Saved the dictionary file
2024-06-13 19:00:24,319 (7f56650a0808) :  INFO (core:611) - Started plug-in
2024-06-13 19:00:24,319 (7f56650a0808) :  DEBUG (socketinterface:160) - Starting socket server
2024-06-13 19:00:24,320 (7f56650a0808) :  DEBUG (runtime:1117) - Created a thread named 'start'
2024-06-13 19:00:24,320 (7f56650a0808) :  INFO (socketinterface:184) - Socket server started on port 38771
2024-06-13 19:00:24,320 (7f56650a0808) :  INFO (pipeinterface:25) - Entering run loop
2024-06-13 19:00:24,320 (7f56650a0808) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2024-06-13 19:00:24,322 (7f56650a0808) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2024-06-13 19:00:24,322 (7f56650a0808) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 157 bytes
140

I have run into the same issue again. Hope it will be fixed soon.

141

Iā€™m getting something like this when i try to download subtitles:

Jan 19, 2025 21:54:03.455 [140536665930552] Debuguj ā€” Request: [10.0.20.236:34426 (Allowed Network (WAN))] PUT /library/metadata/15727/subtitles?codec=srt&key=%2Flibrary%2Fstreams%2F72719&language=pol&providerTitle=OpenSubtitles (14 live) #1ea19 TLS GZIP Signed-in Token (jerry1333) (BRAVIA VH2) / Accept-Encoding => gzip / Accept-Language => pl-pl / Connection => Keep-Alive / Content-Length => 0 / Content-Type => application/x-www-form-urlencoded / Host => 10.0.30.2:32400 / User-Agent => Mozilla/5.0 (Linux; Android 10; BRAVIA 4K VH2 Build/QTG3.200305.006.S414; wv)PlexTV/10.24.1.2319 / X-Plex-Advertising-DoNotTrack => 0 / X-Plex-Advertising-Identifier => xxx / X-Plex-Client-Identifier => xxx / X-Plex-Device => BRAVIA 4K VH2 / X-Plex-Device-Name => BRAVIA VH2 / X-Plex-Device-Screen-Density => 320 / X-Plex-Device-Screen-Resolution => 1920x1080 (tv) / X-Plex-Device-Vendor => Sony / X-Plex-DRM => widevine:video / X-Plex-Features => external-media,indirect-media,hub-style-list / X-Plex-Language => pl-pl / X-Plex-Model => BRAVIA_VH2 / X-Plex-Platform => Android / X-Plex-Platform-Version => 10 / X-Plex-Product => Plex for Android (TV) / X-Plex-Provider-Version => 7.2.0 / X-Plex-Provides => controller / X-Plex-Session-Id => xxx / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx / X-Plex-Version => 10.24.1.2319
Jan 19, 2025 21:54:03.461 [140536665930552] Debuguj ā€” [Req#1ea19] Activity: registered new activity 1dcf377f-181d-440d-8d6a-c737b34fadf2 - "Downloading Subtitle"
Jan 19, 2025 21:54:03.462 [140536578005816] Debuguj ā€” [Req#1ea19] Downloading subtitle from https://metadata.provider.plex.tv/library/streams/10238219?X-Plex-Api-Token=xxxxxxxxxxxxxxxxxxxx
Jan 19, 2025 21:54:03.462 [140536785414968] Debuguj ā€” Completed: [10.0.20.236:34426] 200 PUT /library/metadata/15727/subtitles?codec=srt&key=%2Flibrary%2Fstreams%2F72719&language=pol&providerTitle=OpenSubtitles (14 live) #1ea19 TLS GZIP 6ms 298 bytes (pipelined: 1)
Jan 19, 2025 21:54:03.718 [140536578005816] Debuguj ā€” [Req#1ea19] Got a subtitle of 35 bytes.
Jan 19, 2025 21:54:03.718 [140536578005816] Debuguj ā€” [Req#1ea19] Activity: Ended activity 1dcf377f-181d-440d-8d6a-c737b34fadf2.

But on screen I see Something is wrongā€¦ etc. and no subtitles for me :frowning:

1 Like
142

Same here, it started to do yesterday, i just reinstall the whole system in Docker, today worked well during hours, and bumm now itā€™s broken again. ANy idea???

1 Like
143

Happy to have found this but concerned since the first post was years ago. I just noticed I have this issue today. Canā€™t get subtitles. Not sure when exactly it started happening because I canā€™t recall when I grabbed one last but none of the presented subtitles will download

144

Same here. As others, I see that a very small subtitle file was doownloaded. 99-byte subtitle file is too small to be valid. It seems there is something wrong with subtitle service. Hope it gets fixed soon.

145

exact same issue for me, I am even premium opensubtitles, VIP. tried checking all the logs, no help