search

djdembeck / Audnexus.bundle

An Audnexus client proof of concept for Plex, providing rich author and audiobook data. Developed in Python, offering enhanced user experiences via Plex's legacy plugin agent system.
GNU General Public License v3.0
520 stars 22 forks source link

I just cant seem to make this work. Match immediately fails. #84

Closed amlucent closed 1 year ago

amlucent commented 1 year ago

I just cant seem to make this work. Match immediately fails.

https://imgur.com/MUCLvLQ https://imgur.com/IIKtKnO https://imgur.com/tNgVxTj

seems to be installed correctly https://imgur.com/kmvjGWx

Ive also tried putting folder structure as ./Author/Book Title/Book Title.m4b https://imgur.com/P39XOTw again it fails ASIN number or not. https://imgur.com/APEKZrs

based upon some of the errors I see in the log im wondering if this is a problem because I am running Plex on a linuxserver.io container on podman. (https://github.com/LizardByte/PlexyGlass/issues/25#issuecomment-1272529816)

[root@pod01 PMS Plugin Logs]# tail -100 com.plexapp.agents.audnexus.log
2023-02-12 01:33:31,779 (7f10a89cb808) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 02189b0 (Mon Jan 30 20:24:53 UTC 2023)
2023-02-12 01:33:31,780 (7f10a89cb808) :  DEBUG (core:361) - Using the standard policy
2023-02-12 01:33:31,780 (7f10a89cb808) :  DEBUG (core:450) - Starting runtime component.
2023-02-12 01:33:31,781 (7f10a89cb808) :  DEBUG (core:450) - Starting caching component.
2023-02-12 01:33:31,781 (7f10a89cb808) :  DEBUG (core:450) - Starting data component.
2023-02-12 01:33:31,781 (7f10a89cb808) :  DEBUG (core:450) - Starting networking component.
2023-02-12 01:33:31,781 (7f10a89cb808) :  DEBUG (networking:261) - Loaded HTTP cookies
2023-02-12 01:33:31,782 (7f10a89cb808) :  DEBUG (networking:428) - Setting the default network timeout to 20.0
2023-02-12 01:33:31,782 (7f10a89cb808) :  DEBUG (core:450) - Starting localization component.
2023-02-12 01:33:31,782 (7f10a89cb808) :  INFO (localization:409) - Setting the default locale to en-us
2023-02-12 01:33:31,782 (7f10a89cb808) :  DEBUG (core:450) - Starting messaging component.
2023-02-12 01:33:31,783 (7f10a89cb808) :  DEBUG (core:450) - Starting debugging component.
2023-02-12 01:33:31,783 (7f10a89cb808) :  DEBUG (core:450) - Starting services component.
2023-02-12 01:33:31,783 (7f10a89cb808) :  DEBUG (core:450) - Starting myplex component.
2023-02-12 01:33:31,783 (7f10a580cb38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.audnexus'
2023-02-12 01:33:31,783 (7f10a89cb808) :  DEBUG (core:450) - Starting notifications component.
2023-02-12 01:33:31,878 (7f10a89cb808) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.audnexus in namespace 'metadata'
2023-02-12 01:33:31,881 (7f10a89cb808) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2023-02-12 01:33:32,099 (7f10a89cb808) :  ERROR (networking:196) - Error opening URL 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2023-02-12 01:33:32,100 (7f10a89cb808) :  CRITICAL (runtime:1299) - Exception getting hosted resource hashes (most recent call last):
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-02189b09f/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 "/usr/lib/plexmediaserver/Resources/Plug-ins-02189b09f/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 242, in content
    return self.__str__()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-02189b09f/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 220, in __str__
    self.load()
  File "/usr/lib/plexmediaserver/Resources/Plug-ins-02189b09f/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 158, in load
    f = self._opener.open(req, timeout=self._timeout)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 435, in open
    response = meth(req, response)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 548, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 473, in error
    return self._call_chain(*args)
  File "/usr/lib/plexmediaserver/Resources/Python/python27.zip/urllib2.py", line 407, in _call_chain
    result = func(*args)
  File "/usr/lib/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

2023-02-12 01:33:32,106 (7f10a55ceb38) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2023-02-12 01:33:32,107 (7f10a89cb808) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2023-02-12 01:33:32,107 (7f10a55ceb38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2023-02-12 01:33:32,107 (7f10a89cb808) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2023-02-12 01:33:32,108 (7f10a89cb808) :  DEBUG (core:150) - Finished starting framework core
2023-02-12 01:33:32,108 (7f10a89cb808) :  DEBUG (core:560) - Loading plug-in code
2023-02-12 01:33:32,121 (7f10a5581b38) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400'
2023-02-12 01:33:32,124 (7f10a5581b38) :  DEBUG (core:538) - Machine identifier is db81f97e20c57a30ab46d9795aa7cd92d277433d
2023-02-12 01:33:32,124 (7f10a5581b38) :  DEBUG (core:539) - Server version is 1.31.0.6654-02189b09f
2023-02-12 01:33:32,242 (7f10a89cb808) :  DEBUG (core:566) - Finished loading plug-in code
2023-02-12 01:33:32,295 (7f10a55ceb38) :  DEBUG (services:362) - Loaded services
2023-02-12 01:33:32,297 (7f10a55a4b38) :  DEBUG (services:438) - No shared code to load
2023-02-12 01:33:32,482 (7f10a89cb808) :  DEBUG (agentkit:1132) - Creating new agent class called AudiobookArtist
2023-02-12 01:33:32,482 (7f10a89cb808) :  DEBUG (agentkit:937) - Updating agent information: [{'media_types': ['Artist'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': None, 'languages': ['en'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Audnexus Agent'}]
2023-02-12 01:33:32,483 (7f10a89cb808) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI3CmNvbS5wbGV4YXBwLmFnZW50cy5hdWRuZXh1c3MxMAppZGVudGlmaWVycjEKczEwCmFnZW50X2luZm8xCnIyCjEwCnIzCnMxMQptZWRpYV90eXBlc3I0CnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50bnMxNApjb250cmlidXRlc190b3I1CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczE0CkF1ZG5leHVzIEFnZW50czQKbmFtZTEKczYKQXJ0aXN0MQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWExCnMyCmVucjAK'
2023-02-12 01:33:32,523 (7f10a89cb808) :  DEBUG (agentkit:1132) - Creating new agent class called AudiobookAlbum
2023-02-12 01:33:32,523 (7f10a89cb808) :  DEBUG (agentkit:937) - Updating agent information: [{'media_types': ['Artist'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': None, 'languages': ['en'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Audnexus Agent'}, {'media_types': ['Album'], 'accepts_from': ['com.plexapp.agents.localmedia'], 'fallback_agent': None, 'contributes_to': None, 'languages': ['en'], 'persist_stored_files': True, 'version': 0, 'primary_provider': True, 'prefs': True, 'name': 'Audnexus Agent'}]
2023-02-12 01:33:32,524 (7f10a89cb808) :  DEBUG (networking:143) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI3CmNvbS5wbGV4YXBwLmFnZW50cy5hdWRuZXh1c3MxMAppZGVudGlmaWVycjEKczEwCmFnZW50X2luZm8yCnIyCnI2CjEwCnIzCnMxMQptZWRpYV90eXBlc3I0CnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50bnMxNApjb250cmlidXRlc190b3I1CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczE0CkF1ZG5leHVzIEFnZW50czQKbmFtZTEKczYKQXJ0aXN0MQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWExCnMyCmVuMTAKcjcKczExCm1lZGlhX3R5cGVzcjgKczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRuczE0CmNvbnRyaWJ1dGVzX3RvcjkKczkKbGFuZ3VhZ2VzYjFzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjFzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMTQKQXVkbmV4dXMgQWdlbnRzNApuYW1lMQpzNQpBbGJ1bTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMgplbnIwCg__'
2023-02-12 01:33:32,532 (7f10a89cb808) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json
2023-02-12 01:33:32,534 (7f10a89cb808) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.audnexus
2023-02-12 01:33:32,535 (7f10a89cb808) :  INFO (core:611) - Started plug-in
2023-02-12 01:33:32,535 (7f10a89cb808) :  DEBUG (socketinterface:160) - Starting socket server
2023-02-12 01:33:32,535 (7f10a89cb808) :  DEBUG (runtime:1117) - Created a thread named 'start'
2023-02-12 01:33:32,535 (7f10a89cb808) :  INFO (socketinterface:184) - Socket server started on port 44323
2023-02-12 01:33:32,535 (7f10a89cb808) :  INFO (pipeinterface:25) - Entering run loop
2023-02-12 01:33:32,536 (7f10a89cb808) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2023-02-12 01:33:32,537 (7f10a89cb808) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2023-02-12 01:33:32,537 (7f10a89cb808) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 152 bytes
2023-02-12 23:07:34,546 (7f10a4f4db38) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.audnexus/prefs
2023-02-12 23:07:34,554 (7f10a4f4db38) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.audnexus/prefs
2023-02-12 23:07:34,556 (7f10a4f4db38) :  DEBUG (runtime:88) - Sending packed state data (108 bytes)
2023-02-12 23:07:34,556 (7f10a4f4db38) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 1036 bytes
2023-02-12 23:08:01,309 (7f10a4f4db38) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.audnexus/prefs
2023-02-12 23:08:01,309 (7f10a4f4db38) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.audnexus/prefs
2023-02-12 23:08:01,311 (7f10a4f4db38) :  DEBUG (runtime:88) - Sending packed state data (108 bytes)
2023-02-12 23:08:01,311 (7f10a4f4db38) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 1036 bytes
2023-02-12 23:09:17,595 (7f10a4f4db38) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.audnexus/prefs
2023-02-12 23:09:17,596 (7f10a4f4db38) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.audnexus/prefs
2023-02-12 23:09:17,597 (7f10a4f4db38) :  DEBUG (runtime:88) - Sending packed state data (108 bytes)
2023-02-12 23:09:17,597 (7f10a4f4db38) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 1036 bytes
[root@pod01 PMS Plugin Logs]#
amlucent commented 1 year ago

I was able to resolve this issue by deleting my plex/config/Library/Application\ Support/Plex\ Media\ Server/Plug-in\ Support/Data/com.plexapp.agents.audnexus/ directory and restarting my plex server. It recreated this folder on reboot and all was magically working.

djdembeck commented 1 year ago

Strange, we don't use any of the functions that write to that data folder. Glad it's working now.

schraupt commented 1 year ago

Bild 04 03 23 um 02 55 I just have the same error. But I am using Plex on a Synology. Sometimes the correct book is found but when I try to manually search via Audnexus there comes instantly „Nothing found“. It is so fast that I doubt that there was a real search.