Matching with the Movie Database agent doesn't work?

General Discussions
1

I’ve looked on the forums to see if anyone else has this issue, but couldn’t find a thread.

Last week, my Plex server stopped matching movies in several of my libraries. Even if I manually try to match it and even if I enter the exact title and year as in the Movie Database, it won’t find a match. I even matched up language, but still no go.

Because I wanted to reinstall Plex on another server, I first installed Emby there to troubleshoot, but that seemed to connect to the MovieDB API just fine. I then installed a brand new Plex server (I switched to a Docker container now) and figured a fresh start might help. Still matching against the Movie Database doesn’t work at all, where it always used to work fine.

Does anyone else have this issue or can someone point me in the right direction to troubleshoot this issue?

2

Some logging:
Jun 02, 2018 14:34:27.123 [0x7f5ebcfff700] DEBUG - Refreshing metadata for 'Thor' (agent: ) Jun 02, 2018 14:34:27.123 [0x7f5ebcfff700] DEBUG - Refreshing GUID: 'local://16767' Jun 02, 2018 14:34:27.123 [0x7f5ebcfff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/update?mediaType=1&force=1&guid=local%3A%2F%2F16767&id=16767 Jun 02, 2018 14:34:27.124 [0x7f5ec9bff700] DEBUG - Request: [::ffff:127.0.0.1:36990 (Loopback)] GET /system/agents/update?mediaType=1&force=1&guid=local%3A%2F%2F16767&id=16767 (14 live) GZIP Signed-in Jun 02, 2018 14:34:27.124 [0x7f5ec9bff700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents/update?mediaType=1&force=1&guid=local%3A%2F%2F16767&id=16767 Jun 02, 2018 14:34:27.124 [0x7f5ec9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:34761/system/agents/update?mediaType=1&force=1&guid=local%3A%2F%2F16767&id=16767 Jun 02, 2018 14:34:27.132 [0x7f5edb3ff700] DEBUG - Completed: [::ffff:127.0.0.1:36994] 200 GET /:/plugins (14 live) GZIP 1ms 594 bytes Jun 02, 2018 14:34:27.135 [0x7f5ec9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:34761/system/agents/update?mediaType=1&force=1&guid=local%3A%2F%2F16767&id=16767 Jun 02, 2018 14:34:27.136 [0x7f5ec9bff700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 159 bytes of content. Jun 02, 2018 14:34:27.136 [0x7f5edabfe700] DEBUG - Completed: [::ffff:127.0.0.1:36990] 200 GET /system/agents/update?mediaType=1&force=1&guid=local%3A%2F%2F16767&id=16767 (14 live) GZIP 12ms 486 bytes Jun 02, 2018 14:34:27.136 [0x7f5ebcfff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/update?mediaType=1&force=1&guid=local%3A%2F%2F16767&id=16767 Jun 02, 2018 14:34:27.138 [0x7f5edabfe700] DEBUG - Completed: [::ffff:172.16.3.115:50854] 200 PUT /library/metadata/16767/refresh (14 live) TLS GZIP 15106ms 555 bytes (pipelined: 7) Jun 02, 2018 14:34:27.139 [0x7f5ebebfc700] DEBUG - [com.plexapp.agents.localmedia] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjc2N3M0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMxMwpsb2NhbDovLzE2NzY3czQKZ3VpZHM1CjE2NzY3czIKaWRyMAo_ Jun 02, 2018 14:34:27.139 [0x7f5ebebfc700] DEBUG - HTTP requesting GET http://127.0.0.1:44197/:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjc2N3M0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMxMwpsb2NhbDovLzE2NzY3czQKZ3VpZHM1CjE2NzY3czIKaWRyMAo_ Jun 02, 2018 14:34:27.142 [0x7f5edabfe700] DEBUG - Completed: [::ffff:127.0.0.1:37000] 200 GET /:/metadata/processing?id=16767 (14 live) GZIP 1ms 166 bytes Jun 02, 2018 14:34:27.155 [0x7f5ecbbfe700] DEBUG - We're going to try to auto-select an audio stream for account 1. Jun 02, 2018 14:34:27.155 [0x7f5ecbbfe700] DEBUG - Selecting best audio stream for part ID 15721 (autoselect: 1 language: nl) Jun 02, 2018 14:34:27.155 [0x7f5ecbbfe700] DEBUG - We're going to try to auto-select a subtitle. Jun 02, 2018 14:34:27.155 [0x7f5ecbbfe700] DEBUG - Selected a foreign audio track Jun 02, 2018 14:34:27.155 [0x7f5ecbbfe700] DEBUG - Found a suitable native subtitle language [dut] for a foreign film Jun 02, 2018 14:34:27.155 [0x7f5ecbbfe700] DEBUG - Audio Stream: 24345, Subtitle Stream: 24346 Jun 02, 2018 14:34:27.156 [0x7f5ecbbfe700] DEBUG - Activity: registered new activity d7336308-3978-4031-93df-e4f225a702af - Refreshing Jun 02, 2018 14:34:27.157 [0x7f5ebe3fb700] DEBUG - Activity: updated activity d7336308-3978-4031-93df-e4f225a702af - completed 0% - Refreshing Jun 02, 2018 14:34:27.158 [0x7f5ebe3fb700] DEBUG - Activity: updated activity d7336308-3978-4031-93df-e4f225a702af - completed 33% - Refreshing Jun 02, 2018 14:34:27.158 [0x7f5ebe3fb700] DEBUG - Activity: updated activity d7336308-3978-4031-93df-e4f225a702af - completed 66% - Refreshing Jun 02, 2018 14:34:27.158 [0x7f5ebe3fb700] DEBUG - Activity: Ended activity d7336308-3978-4031-93df-e4f225a702af. Jun 02, 2018 14:34:27.158 [0x7f5edb3ff700] DEBUG - Completed: [::ffff:172.16.3.115:50850] 200 GET /library/metadata/16767?skipRefresh=1&includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeChapters=1&asyncCheckFiles=1&asyncRefreshAnalysis=1&asyncRefreshLocalMediaAgent=1 (14 live) TLS GZIP 11ms 1338 bytes (pipelined: 6) Jun 02, 2018 14:34:27.175 [0x7f5edb3ff700] DEBUG - Completed: [::ffff:172.16.3.115:50854] 200 GET /hubs/metadata/16767/related?excludeFields=summary&count=12 (13 live) TLS GZIP 15ms 551 bytes (pipelined: 8) Jun 02, 2018 14:34:27.189 [0x7f5edb3ff700] DEBUG - Completed: [::ffff:127.0.0.1:37002] 200 GET /library/metadata/16767/tree (14 live) GZIP 4ms 908 bytes Jun 02, 2018 14:34:27.211 [0x7f5ebebfc700] DEBUG - HTTP 200 response from GET http://127.0.0.1:44197/:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjc2N3M0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMxMwpsb2NhbDovLzE2NzY3czQKZ3VpZHM1CjE2NzY3czIKaWRyMAo_ Jun 02, 2018 14:34:27.211 [0x7f5ebebfc700] DEBUG - [com.plexapp.agents.localmedia] HTTP reply status 200, with 16 bytes of content. Jun 02, 2018 14:34:27.211 [0x7f5edb3ff700] DEBUG - Completed: [::ffff:127.0.0.1:36996] 200 GET /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjc2N3M0CmRiaWRpMApzNwp2ZXJzaW9ubnMxMApwYXJlbnRHVUlEbnM4CnBhcmVudElEczUKTW92aWVzMTAKbWVkaWFfdHlwZXMxMwpsb2NhbDovLzE2NzY3czQKZ3VpZHM1CjE2NzY3czIKaWRyMAo_ (14 live) GZIP 72ms 476 bytes Jun 02, 2018 14:34:27.234 [0x7f5edb3ff700] DEBUG - Completed: [::ffff:127.0.0.1:37004] 200 GET /library/metadata/16767/tree (14 live) GZIP 3ms 908 bytes Jun 02, 2018 14:34:27.245 [0x7f5ecbbfe700] DEBUG - Queueing up local://16767 for loading, there are 0 items in the queue. Jun 02, 2018 14:34:27.245 [0x7f5edb3ff700] DEBUG - Completed: [::ffff:127.0.0.1:37006] 200 GET /:/metadata/notify?guid=local%3A%2F%2F16767&path=Movies%2F6%2Fcdaad516065efedd32cab9e12c9f744e1786dfa.bundle&force=1&queueSize=0&id=16767&success=1&async=1 (15 live) GZIP 0ms 166 bytes Jun 02, 2018 14:34:27.247 [0x7f5ec03ff700] DEBUG - Notification of new metadata for local://16767 [id=16767] (success=1) for 1 items. Jun 02, 2018 14:34:27.250 [0x7f5ec03ff700] DEBUG - Loading Movie 'Thor' XML from /config/Library/Application Support/Plex Media Server/Metadata/Movies/6/cdaad516065efedd32cab9e12c9f744e1786dfa.bundle/Contents/_combined/ Jun 02, 2018 14:34:27.251 [0x7f5ec03ff700] DEBUG - Item 16767 (Thor) Scanning metadata graphic elements in XML file ""/Info.xml Jun 02, 2018 14:34:27.251 [0x7f5ec03ff700] DEBUG - Item 16767 (Thor) Scanning metadata graphic elements in XML file ""/Info.xml Jun 02, 2018 14:34:27.255 [0x7f5ec03ff700] DEBUG - Loading information from media bundle for part ID 15721 from "/config/Library/Application Support/Plex Media Server/Media/localhost/9/c324483d1e81ae0f57a697641007b14539c77e6.bundle/Contents" Jun 02, 2018 14:34:27.255 [0x7f5ec03ff700] DEBUG - Loaded metadata for Thor (ID 16767) in 10.000000 ms Jun 02, 2018 14:34:27.255 [0x7f5ec03ff700] DEBUG - There was a change for metadata item 16767 (Thor), saving. Jun 02, 2018 14:34:27.255 [0x7f5ec03ff700] DEBUG - Updating metadata item (save) (Thor) with ID 16767 Jun 02, 2018 14:34:27.309 [0x7f5ec03ff700] DEBUG - Done with metadata update for 16767
I can’t see any error that nudges me to the right solution. Anyone?

3

In the logs (debug off):
Jun 02, 2018 14:45:15.894 [0x7f5ebaffd700] ERROR - Error issuing curl_easy_perform(handle): 28
Jun 02, 2018 14:45:37.836 [0x7f5ebaffd700] ERROR - Error issuing curl_easy_perform(handle): 28
Jun 02, 2018 14:45:37.849 [0x7f5eb97ff700] WARN - No matches for search.
Jun 02, 2018 14:46:03.997 [0x7f5ebaffd700] ERROR - Error issuing curl_easy_perform(handle): 28
Jun 02, 2018 14:46:04.008 [0x7f5ebfbfe700] WARN - No matches for search.
Jun 02, 2018 14:46:37.809 [0x7f5ec9bff700] ERROR - Error issuing curl_easy_perform(handle): 28
Jun 02, 2018 14:46:37.823 [0x7f5ebcfff700] WARN - No matches for search.

Example:
Movie file named Deadpool-(2016).mkv. That should easily be found on TheMovieDB.

4

could there be anything interfering with those network requests/lookups – any firewall or “security” apps on your server or router?

5

Settings - Server - Network - ‘Show Advanced’ - “Enable IPv6” <-- DISABLE
Afterwards, restart Plex server

You might even have to disable IPv6 at the OS level.

Do also this (even if it sounds weird):
Settings - Server - Agents - Movies - TheMovieDatabase
grab one of the lines with a checkmark in front of it
move it up or downwards and release the mouse button
then drag it back to where it was.

6

I’m pretty sure it’s not the router. had it for over a year and I didn’t change any settings on it. Other stuff in my network has no issues.
Disabled IPv6, but that also didn’t help. My ISP supports native IPv6, so I have it enabled on my network, laptops and servers.
Dragging also didn’t solve the issue. In fact, it is now not downloading some of the artwork from The TVDB, for example for NOVA (which definitely has artwork). Matching for the TVDB works just fine. It did download artwork for The Shannara Chronicles.
The “ERROR - Error issuing curl_easy_perform(handle): 28” messages persist.

Just to be sure; this is my docker-compose for PMS:
plexms: container_name: plexms restart: always image: plexinc/pms-docker network_mode: host volumes: - ${USERDIR}/docker/plexms:/config - ${USERDIR}/Downloads/plex_tmp:/transcode - /mnt/Media/Movies:/media/Movies:ro - /mnt/Media/TV:/media/TV:ro - ${USERDIR}/docker/shared:/shared ports: - "32400:32400/tcp" - "3005:3005/tcp" - "8324:8324/tcp" - "32469:32469/tcp" - "1900:1900/udp" - "32410:32410/udp" - "32412:32412/udp" - "32413:32413/udp" - "32414:32414/udp" environment: - TZ=${TZ} - HOSTNAME="MyPlexServer" - PLEX_CLAIM="claim-xxxxx" - PLEX_UID=${PUID} - PLEX_GID=${PGID} - ADVERTISE_IP="http://192.168.0.90:32400/"
Running the above config without network_mode in host causes Plex to lose the remote access connection.
Server: Ubuntu 18.04 with latest (nightly) Docker-CE build with PMS 1.13.0.5023.
I have similar issues on my old server which is an Arch Linux box (up-to-date) with the same PMS version.

7

I spun up a new container with a fresh config and tried again. That solved the issue. Either it was an issue with the settings, or there where API issues at the MovieDB that were solved when I started my fresh install yesterday.
Either way; case closed.

Thanks to everyone that responded to this thread. Much appreciated!

8

@OttoKerner said:
Settings - Server - Network - ‘Show Advanced’ - “Enable IPv6” ← DISABLE
Afterwards, restart Plex server

You might even have to disable IPv6 at the OS level.

Do also this (even if it sounds weird):
Settings - Server - Agents - Movies - TheMovieDatabase
grab one of the lines with a checkmark in front of it
move it up or downwards and release the mouse button
then drag it back to where it was.

Thank you so much. It´s worked for me !!!

9

i’m having similar problem here. i had my nas in storage for 6 months while a move happened. now i’ve got it set up in my new place and now some new movies i’ve added won’t match with the movie db. i can eventually find a match with the Plex Movie scan, but that doesn’t provide any posters and you can see the cast names but no pics. i’ve upgraded my plex server and it hasn’t helped (v. 1.13.3.5223). ipv6 is turned off. i’ve done the plex dance. i’ve moved the agent list around. my router has a firewall on it, i’ve tried with it both off and on.
using windows on the pc’s, server is on a synology nas

10

Have you checked to make sure your server is listed as a Private Network instead of a Public one? I had the issue you’re having, and that was the fix for me. Good luck!

11

don’t see such a setting for my NAS.