PMS 1.23.4 - Can't connect to server from multiple clients

Paleosonic · July 21, 2022, 3:30pm

QNAP TS-253A Version: 5.0.0.2055
Plex Media Server Version#: 1.23.4
Plex iOS Player Version#: 8.0

I’ve been using Plex without issues for years. But after recent updates, I can fill only my account details, and then it ends in “Unable to connect” (browser) or “No Content from Your Pinned Sources” (app) and “Unable to add connection Error code: -1004” (app).

Got errors in:
Plex Media Server.log

Jul 21, 2022 16:26:41.559 [0x7f3e0eec3b38] WARN - Waited one whole second for a busy database.
Jul 21, 2022 16:26:41.793 [0x7f3e0f7bdb38] WARN - Waited one whole second for a busy database.
Jul 21, 2022 16:26:42.774 [0x7f3e0eec3b38] ERROR - Saving activity history aborted with soci exception: sqlite3_statement_backend::loadOne: database is locked
Jul 21, 2022 16:26:48.045 [0x7f3e0f7bdb38] WARN - Waited one whole second for a busy database.
Jul 21, 2022 16:26:48.245 [0x7f3e0eec3b38] WARN - Waited one whole second for a busy database.
Jul 21, 2022 16:26:49.053 [0x7f3e0f7bdb38] ERROR - Failed to begin transaction (../Plugins/PluginDatabaseState.cpp:110) (tries=10): Cannot begin transaction. database is locked

com.plexapp.system.log

2022-07-21 16:25:48,009 (7f1240324848) :  CRITICAL (runtime:709) - Private handlers are no longer supported; couldn't register <bound method StreamService.token_handler of <streamservice.StreamService object at 0x7f123d0e8c90>>
2022-07-21 16:26:19,474 (7f123d575b38) :  CRITICAL (runtime:1299) - Exception getting hosted resource hashes (most recent call last):
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/runtime.py", line 1291, in get_resource_hashes
    json = self._core.networking.http_request("http://resources-cdn.plexapp.com/hashes.json", timeout=5).content
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/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-186bae04e/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-186bae04e/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 403: Forbidden
2022-07-21 16:27:48,011 (7f123d2c7b38) :  CRITICAL (runtime:1128) - Exception in thread named 'refresh_servers' (most recent call last):
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/runtime.py", line 1126, in _start_thread
    f(*args, **kwargs)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/System.bundle/Contents/Code/peerservice.py", line 169, in refresh_servers
    servers_el = self.get_servers_el()
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/System.bundle/Contents/Code/peerservice.py", line 165, in get_servers_el
    return XML.ElementFromURL('http://127.0.0.1:32400/servers', cacheTime = 0)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/api/parsekit.py", line 344, in ElementFromURL
    method=method,
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/api/networkkit.py", line 67, in _http_request
    req = self._core.networking.http_request(url, *args, **kwargs)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 346, in http_request
    return HTTPRequest(self._core, url, data, h, url_cache, encoding, errors, timeout, immediate, sleep, opener, follow_redirects, method)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/Framework.bundle/Contents/Resources/Versions/2/Python/Framework/components/networking.py", line 118, in __init__
    self.load()
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/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 429, in open
    response = self._open(req, data)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Python/python27.zip/urllib2.py", line 447, in _open
    '_open', req)
  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 1228, in http_open
    return self.do_open(httplib.HTTPConnection, req)
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Python/python27.zip/urllib2.py", line 1198, in do_open
    raise URLError(err)
URLError: <urlopen error [Errno 111] Connection refused>

com.plexapp.agents.imdb.log

2022-07-21 16:26:19,481 (7f3dd8e89848) :  ERROR (networking:196) - Error opening URL 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2022-07-21 16:26:19,486 (7f3dd8e89848) :  CRITICAL (runtime:1299) - Exception getting hosted resource hashes (most recent call last):
  File "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-186bae04e/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-186bae04e/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-186bae04e/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-186bae04e/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

Hope this makes sense to someone who can help me fix the server.

ChuckPa · July 21, 2022, 3:46pm

May I see the entire log ZIP please?

Excepts don’t help.

ALSO, before sending, is DEBUG logging enabled or had you previously turned it down to INFO/ERROR only?

Paleosonic · July 21, 2022, 4:01pm

Thx for your swift respons!
I’m afraid I have debug and verbose enabled.
What is the command to turn those off?

ChuckPa · July 21, 2022, 4:11pm

You change the settings in

Settings - Server - General - SHOW ADVANCED.

Uncheck the box for VERBOSE
Click SAVE at the bottom.

Now recreate the problem and capture a fresh ZIP file.

If you can’t then grab the ZIP you do have. I’ll sort through it.

Paleosonic · July 21, 2022, 5:33pm

I wish I could load the PMS web-interface to change such settings.
Anyway I removed some trivial lines from the logs for convenience.

pms-log.zip (20.0 KB)

ChuckPa · July 21, 2022, 7:23pm

Thanks for those logs.

In QTS, which adapter is marked as your default ? br0 or qvs0 ?

Jul 21, 2022 18:46:53.067 [0x7fbd88f83d30] DEBUG - NetworkInterface: Notified of network changed (force=0)
Jul 21, 2022 18:46:53.068 [0x7fbd88f83d30] DEBUG - Detected primary interface: 192.168.122.75
Jul 21, 2022 18:46:53.068 [0x7fbd88f83d30] DEBUG - Network interfaces:
Jul 21, 2022 18:46:53.068 [0x7fbd88f83d30] DEBUG -  * 1 lo (127.0.0.1) (loopback: 1)
Jul 21, 2022 18:46:53.069 [0x7fbd88f83d30] DEBUG -  * 7 br0 (192.168.122.75) (loopback: 0)
Jul 21, 2022 18:46:53.069 [0x7fbd88f83d30] DEBUG -  * 8 qvs0 (192.168.79.4) (loopback: 0)
Jul 21, 2022 18:46:53.069 [0x7fbd88f83d30] DEBUG -  * 9 vethgw01 (253.253.253.253) (loopback: 0)

I see in your logs where they seem to be confused about which network is in use.
I see devices from both subnets trying to contact PMS.

PMS itself is authenticating properly with Plex.tv.
This confirms we aren’t stuck with DNS issues.

Jul 21, 2022 18:48:01.705 [0x7fbd87466b38] DEBUG - Auth: authenticated user 1 as Paleosonic
Jul 21, 2022 18:48:01.705 [0x7fbd87466b38] VERBOSE - Auth: Came in with a super-token, authorization succeeded.

Paleosonic · July 21, 2022, 8:55pm

Thank you for looking into this.

The br0 is QTS default and part of my personal home network. The qvs0 is a vlan guest network for an unmanaged smart tv and setup box. This setup has been working fine besides a small issue for the setup box.

Do you think this setup might be conflicting and keep devices from both subnets from connecting to the Plex server?

I’ll try disconnecting the qvs0 and watch if this restore the home network connection.

ChuckPa · July 21, 2022, 8:57pm

Which subnet are your home devices on (TV, etc) ?

If they are on 192.168.122.x then all should be OK.
(clients cannot search for PMS across subnet boundaries)

Paleosonic · July 21, 2022, 9:46pm

My desktop, laptop and mobile devices are on the 192.168.122.x home subnet. The smart TV and TV setup box are on the 192.168.79.x guest subnet, and provide some extra security. (Maybe I am a bit paranoid about devices that are managed by commercial parties and don’t allow me admin access?)

Hmm, after disconnecting the guest network from the NAS, I could access the PMS web interface again. Though it could not connect to the q-nas. So I removed it and lost all connections.

After plugging in the guest network cable again, I can connect to PMS from both home network as guest network!
I have no clue why it is behaving as it used to do, perhaps the many restarts?

ChuckPa · July 21, 2022, 9:51pm

From your laptop on the 192.168.122.x network -

You should be able to:

Open the QNAP on http://192.168.122.75:8080

Open an incognito browser window
Go to http://192.168.122.75:32400/web

If connecting the VLAN cable restores functionality then I suspect the network is not wired as you think it is.

Do you have VLAN tagging in your switch and might it be misconfigured?

Paleosonic · July 21, 2022, 10:26pm

Both addresses connect as they should in regular and private windows.

I’m sure the network is wired as I think it is, though a secure connection to PMS gives an error:
Secure Connection Failed
An error occurred during a connection to 192.168.122.75:32400. PR_END_OF_FILE_ERROR

I didn’t tag any device with VLAN, I just abuse the guest network on the modem/router as a separate network. And it is this undocumented feature that might be the culprit.

I’m seriously considering to put all devices in the same group for simplicity sake.

ChuckPa · July 21, 2022, 10:30pm

See Below

ChuckPa · July 21, 2022, 10:36pm

Try a different browser

system · October 19, 2022, 10:37pm

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.

Topic		Replies	Views
Error Connection Refused NAS & Devices server-qnap	156	10884	January 8, 2020
Cannot log into plex.tv / app.plex.tv / anywhere / claim server (shouldn't have to, not new) Plex Media Server server-qnap	2	47	September 18, 2025
Short Lived QNAP PMS instance NAS & Devices server-qnap	6	59	December 9, 2024
PMS not reachable in my QNAP NAS NAS & Devices server-qnap	35	822	November 23, 2021
I cannot access my server with “app.plex.tv” Plex Media Server server-qnap , plex-web	18	327	September 3, 2021

PMS 1.23.4 - Can't connect to server from multiple clients

Related topics