Hi,
I was trying to refresh metadata for a tv documentary and plex cannot find the show. Although I can manually find it in TvDb. On further investigation I noticed that TvDb plugin is not running despite restarting plex server multiple times.
This is what is running
ps ax | grep plex
92833 - IsJ 0:19.72 /usr/local/share/plexmediaserver-plexpass/Plex_Media_Server (Plex Media Server)
92834 - INJ 0:16.87 Plex Plug-in [com.plexapp.system] /usr/local/share/plexmediaserver-plexpass/Resources/Plug-ins-10d48da0d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py –
92844 - IJ 0:02.27 /usr/local/share/plexmediaserver-plexpass/Plex DLNA Server
92845 - IJ 0:00.11 /usr/local/share/plexmediaserver-plexpass/Plex Tuner Service /usr/local/share/plexmediaserver-plexpass/Resources/Tuner/Private /usr/local/share/plexmediaserver-plexpass/Resou
92846 - IJ 0:06.57 Plex Plug-in [com.plexapp.agents.imdb] /usr/local/share/plexmediaserver-plexpass/Resources/Plug-ins-10d48da0d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.
92893 - IJ 0:04.59 Plex Plug-in [com.plexapp.plugins.comedycentral] /usr/local/share/plexmediaserver-plexpass/Resources/Plug-ins-10d48da0d/Framework.bundle/Contents/Resources/Versions/2/Python/
93140 - IJ 0:06.19 Plex Plug-in [com.plexapp.agents.localmedia] /usr/local/share/plexmediaserver-plexpass/Resources/Plug-ins-10d48da0d/Framework.bundle/Contents/Resources/Versions/2/Python/boot
93536 0 S+J 0:00.00 grep plex
Server Version#: 1.13.8.5395
Player Version#:
Plex Media Server Logs
Dec 30, 2018 21:53:02.803 [0x80b299500] DEBUG - Auth: authenticated user 1 as c@gmail.com
Dec 30, 2018 21:53:02.804 [0x80b29db00] DEBUG - Request: [192.168.1.186:54663 (Subnet)] PUT /library/metadata/225191/refresh (5 live) TLS GZIP Signed-in Token (cv@gmail.com)
Dec 30, 2018 21:53:02.806 [0x80b29db00] DEBUG - Matching ‘Bbc Dynasties’ (ID 225191) with agent
Dec 30, 2018 21:53:02.811 [0x80b29db00] DEBUG - Most recent grandchild was episode 5
Dec 30, 2018 21:53:02.812 [0x80b29db00] DEBUG - Issuing search query: http://127.0.0.1:32400/system/agents/search?mediaType=2&id=225191&identifier=com.plexapp.agents.thetvdb&duration=3466047&episodic=1&filename=%2Fmedia%2FDocumentaries%2FBBC%20-%20Dynasties%2FBBC%20Dynasties%20S01E05%2Emp4&lang=en&openSubtitlesHash=882e171dea87230e&plexHash=3e31913b438c501bc4e9e81d98e85753f17a6a99&episode=5&episodic=1&season=1&show=Bbc%20Dynasties
Dec 30, 2018 21:53:02.812 [0x80b29db00] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/search?mediaType=2&id=225191&identifier=com.plexapp.agents.thetvdb&duration=3466047&episodic=1&filename=%2Fmedia%2FDocumentaries%2FBBC%20-%20Dynasties%2FBBC%20Dynasties%20S01E05%2Emp4&lang=en&openSubtitlesHash=882e171dea87230e&plexHash=3e31913b438c501bc4e9e81d98e85753f17a6a99&episode=5&episodic=1&season=1&show=Bbc%20Dynasties
Dec 30, 2018 21:53:02.813 [0x80b299a00] DEBUG - Request: [192.168.1.5:21121 (Subnet)] GET /system/agents/search?mediaType=2&id=225191&identifier=com.plexapp.agents.thetvdb&duration=3466047&episodic=1&filename=%252Fmedia%252FDocumentaries%252FBBC%2520-%2520Dynasties%252FBBC%2520Dynasties%2520S01E05%252Emp4&lang=en&openSubtitlesHash=882e171dea87230e&plexHash=3e31913b438c501bc4e9e81d98e85753f17a6a99&episode=5&episodic=1&season=1&show=Bbc%20Dynasties (6 live) GZIP Signed-in
Dec 30, 2018 21:53:02.813 [0x80b29db00] DEBUG - HTTP 401 response from GET http://127.0.0.1:32400/system/agents/search?mediaType=2&id=225191&identifier=com.plexapp.agents.thetvdb&duration=3466047&episodic=1&filename=%2Fmedia%2FDocumentaries%2FBBC%20-%20Dynasties%2FBBC%20Dynasties%20S01E05%2Emp4&lang=en&openSubtitlesHash=882e171dea87230e&plexHash=3e31913b438c501bc4e9e81d98e85753f17a6a99&episode=5&episodic=1&season=1&show=Bbc%20Dynasties
Dec 30, 2018 21:53:02.813 [0x80b299a00] DEBUG - Completed: [192.168.1.5:21121] 401 GET /system/agents/search?mediaType=2&id=225191&identifier=com.plexapp.agents.thetvdb&duration=3466047&episodic=1&filename=%252Fmedia%252FDocumentaries%252FBBC%2520-%2520Dynasties%252FBBC%2520Dynasties%2520S01E05%252Emp4&lang=en&openSubtitlesHash=882e171dea87230e&plexHash=3e31913b438c501bc4e9e81d98e85753f17a6a99&episode=5&episodic=1&season=1&show=Bbc%20Dynasties (6 live) GZIP 0ms 338 bytes
Dec 30, 2018 21:53:02.814 [0x80b29db00] DEBUG - -1: ()
Dec 30, 2018 21:53:02.814 [0x80b29db00] DEBUG - -1: ()
Dec 30, 2018 21:53:02.814 [0x80b29db00] DEBUG - * Score: -1 ()
Dec 30, 2018 21:53:02.814 [0x80b29db00] DEBUG - Refreshing metadata for ‘Bbc Dynasties’ (agent: )
Dec 30, 2018 21:53:02.814 [0x80b29db00] DEBUG - Refreshing GUID: ‘local://225191’
Dec 30, 2018 21:53:02.814 [0x80b29db00] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/update?mediaType=2&force=1&guid=local%3A%2F%2F225191&id=225191
Dec 30, 2018 21:53:02.815 [0x80b299a00] DEBUG - Request: [192.168.1.5:56716 (Subnet)] GET /system/agents/update?mediaType=2&force=1&guid=local%3A%2F%2F225191&id=225191 (6 live) GZIP Signed-in
Dec 30, 2018 21:53:02.816 [0x80b29db00] DEBUG - HTTP 401 response from GET http://127.0.0.1:32400/system/agents/update?mediaType=2&force=1&guid=local%3A%2F%2F225191&id=225191
Dec 30, 2018 21:53:02.816 [0x80b299a00] DEBUG - Completed: [192.168.1.5:56716] 401 GET /system/agents/update?mediaType=2&force=1&guid=local%3A%2F%2F225191&id=225191 (6 live) GZIP 0ms 338 bytes
Dec 30, 2018 21:53:02.816 [0x80b29db00] ERROR - Error response for update: ().
Dec 30, 2018 21:53:02.818 [0x80b299a00] DEBUG - Completed: [192.168.1.186:54663] 200 PUT /library/metadata/225191/refresh (5 live) TLS GZIP 14ms 555 bytes (pipelined: 1)
Dec 30, 2018 21:53:02.909 [0x80b299500] DEBUG - Auth: authenticated user 1 as cv@gmail.com
Dec 30, 2018 21:53:02.910 [0x80c240f00] DEBUG - Request: [192.168.1.186:54667 (Subnet)] GET /library/metadata/225191/children?excludeAllLeaves=1 (8 live) TLS Page 0-0 GZIP Signed-in Token (cv@gmail.com)
Dec 30, 2018 21:53:02.914 [0x80c240f00] DEBUG - Setting container serialization range to [0, 0] (total=-1)
Dec 30, 2018 21:53:02.917 [0x80c240f00] DEBUG - Setting container serialization range to [0, 0] (total=1)
Dec 30, 2018 21:53:02.920 [0x80b299500] DEBUG - Completed: [192.168.1.186:54667] 200 GET /library/metadata/225191/children?excludeAllLeaves=1 (8 live) TLS GZIP Page 0-0 10ms 912 bytes (pipelined: 1)
Dec 30, 2018 21:53:03.070 [0x80b299500] DEBUG - Auth: authenticated user 1 as cv@gmail.com
Dec 30, 2018 21:53:03.070 [0x80b299a00] DEBUG - Auth: authenticated user 1 as cv@gmail.com
Dec 30, 2018 21:53:03.070 [0x80b29db00] DEBUG - Request: [192.168.1.186:54669 (Subnet)] GET /hubs/metadata/225191/related?excludeFields=summary&count=12 (8 live) TLS GZIP Signed-in Token (cv@gmail.com)
TvDb Plugin log:
018-12-27 19:12:49,156 (802016000) : DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.thetvdb in namespace ‘metadata’
2018-12-27 19:12:49,212 (802016000) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes’
2018-12-27 19:12:54,294 (8021cb700) : DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-12-27 19:12:54,295 (802016000) : DEBUG (runtime:1117) - Created a thread named ‘load_all_services’
2018-12-27 19:12:54,298 (802016000) : DEBUG (runtime:1117) - Created a thread named ‘get_server_info’
2018-12-27 19:12:54,298 (802016000) : DEBUG (core:150) - Finished starting framework core
2018-12-27 19:12:54,299 (802016000) : DEBUG (core:560) - Loading plug-in code
2018-12-27 19:12:54,404 (8021cb700) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_’
2018-12-27 19:12:54,417 (8023a1300) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400’
2018-12-27 19:12:55,307 (8021cb700) : DEBUG (services:362) - Loaded services
2018-12-27 19:12:55,321 (80239f500) : DEBUG (services:438) - No shared code to load
2018-12-27 19:12:56,220 (802016000) : DEBUG (core:566) - Finished loading plug-in code
2018-12-27 19:12:56,223 (802016000) : DEBUG (agentkit:1115) - Creating new agent class called TVDBAgent
2018-12-27 19:12:56,226 (802016000) : DEBUG (agentkit:933) - Updating agent information: [{‘media_types’: [‘TV_Show’], ‘accepts_from’: None, ‘fallback_agent’: None, ‘contributes_to’: None, ‘languages’: [‘en’, ‘fr’, ‘zh’, ‘sv’, ‘no’, ‘da’, ‘fi’, ‘nl’, ‘de’, ‘it’, ‘es’, ‘pl’, ‘hu’, ‘el’, ‘tr’, ‘ru’, ‘he’, ‘ja’, ‘pt’, ‘cs’, ‘ko’, ‘sl’, ‘hr’], ‘persist_stored_files’: True, ‘version’: 0, ‘primary_provider’: True, ‘prefs’: True, ‘name’: ‘TheTVDB’}]
2018-12-27 19:12:56,268 (802016000) : DEBUG (networking:166) - Requesting ‘http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo1CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdAoyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMxMAppZGVudGlmaWVycjEKczEwCmFnZW50X2luZm8xCnIyCjEwCnIzCnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudG5zMTQKY29udHJpYnV0ZXNfdG9yNApzOQpsYW5ndWFnZXNiMXMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMXMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3M3ClRoZVRWREJzNApuYW1lMQpzNwpUVl9TaG93MjMKczIKZW5zMgpmcnMyCnpoczIKc3ZzMgpub3MyCmRhczIKZmlzMgpubHMyCmRlczIKaXRzMgplc3MyCnBsczIKaHVzMgplbHMyCnRyczIKcnVzMgpoZXMyCmphczIKcHRzMgpjc3MyCmtvczIKc2xzMgpocnIwCg__’
2018-12-27 19:12:56,293 (802016000) : INFO (core:611) - Started plug-in
2018-12-27 19:12:56,294 (802016000) : DEBUG (socketinterface:160) - Starting socket server
2018-12-27 19:12:56,296 (802016000) : DEBUG (runtime:1117) - Created a thread named ‘start’
2018-12-27 19:12:56,297 (802016000) : INFO (socketinterface:184) - Socket server started on port 58456
2018-12-27 19:12:56,298 (802016000) : INFO (pipeinterface:25) - Entering run loop
2018-12-27 19:12:56,299 (802016000) : DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-12-27 19:12:56,304 (802016000) : DEBUG (runtime:814) - Found route matching /:/prefixes
2018-12-27 19:12:56,306 (802016000) : DEBUG (runtime:924) - Response: [200] MediaContainer, 151 bytes
2018-12-27 19:12:59,285 (8023a1300) : DEBUG (core:538) - Machine identifier is 302fdb027475aff704612ascscsch182e67
2018-12-27 19:12:59,286 (8023a1300) : DEBUG (core:539) - Server version is 1.13.8.5395-10d48da0d
2018-12-30 21:35:51,485 (802016000) : INFO (pipeinterface:87) - Stopping plug-in