QNAP - PMS Won't Start

Server Version#: 1.40.2
QNAP TS-464
QTS 5.1.7.2770

PMS stopped working a couple of days ago. I have used the this tool to repair the database:
Plex Media Server Database Repair Utility v1.06.02
After the database is repaired and rebuilt, I sill cannot start PMS. Here is the log from the tool above:

2024-05-26 09.08.12 - Auto - START
2024-05-26 09.08.14 - Check - Check com.plexapp.plugins.library.db - PASS
2024-05-26 09.08.14 - Check - Check com.plexapp.plugins.library.blobs.db - PASS
2024-05-26 09.08.14 - Check - PASS
2024-05-26 09.08.21 - Repair - Export databases - PASS
2024-05-26 09.08.35 - Repair - Import - PASS
2024-05-26 09.08.38 - Repair - Verify main database - PASS (Size: 142MB/142MB).
2024-05-26 09.08.38 - Repair - Verify blobs database - PASS (Size: 13MB/13MB).
2024-05-26 09.08.38 - Making repaired databases active
2024-05-26 09.08.38 - Repair - Move files - PASS
2024-05-26 09.08.38 - Repair - PASS
2024-05-26 09.08.38 - Repair - PASS
2024-05-26 09.08.38 - Reindex - MakeBackup com.plexapp.plugins.library.db - PASS
2024-05-26 09.08.38 - Reindex - MakeBackup com.plexapp.plugins.library.blobs.db - PASS
2024-05-26 09.08.38 - Reindex - MakeBackup - PASS
2024-05-26 09.08.48 - Reindex - Reindex: com.plexapp.plugins.library.db - PASS
2024-05-26 09.08.48 - Reindex - Reindex: com.plexapp.plugins.library.blobs.db - PASS
2024-05-26 09.08.48 - Reindex - PASS
2024-05-26 09.08.48 - Reindex - PASS
2024-05-26 09.08.48 - Auto - COMPLETED
2024-05-26 09.09.09 - Start - FAIL (1)

I have tried to run each tool option separately, but I get to the same “Start - FAIL (1)”.
I am out of ideas, so any help is welcome. Thanks,

Investigating. Will reply again as soon as I have some feedback

Thanks Chuck.
I am not sure if this help, but as I was looking at some other logs, I found this following log:
Plex Media Server.log:

May 26, 2024 08:28:45.087 [140025081781048] INFO - Plex Media Server v1.40.2.8395-c67dce28e - QNAP TS-464 x86_64 - build: linux-x86_64 qnap - GMT -10:00
May 26, 2024 08:28:45.087 [140025081781048] INFO - Linux version: QTS 5.1.7.2770, language: en-US
May 26, 2024 08:28:45.087 [140025081781048] INFO - Processor: 4-core Intel(R) Celeron(R) N5095 @ 2.00GHz
May 26, 2024 08:28:45.087 [140025081781048] INFO - Compiler is - Clang 11.0.1 (https://plex.tv 9b997da8e5b47bdb4a9425b3a3b290be393b4b1f)
May 26, 2024 08:28:45.087 [140025081781048] INFO - ./Plex Media Server
May 26, 2024 08:28:45.116 [140025084340880] INFO - [CERT/OCSP] No relevant response in cache.
May 26, 2024 08:28:45.116 [140025084340880] INFO - [CERT/OCSP] Couldn't install the cached response; fetching from network.
May 26, 2024 08:28:45.646 [140025084340880] INFO - Running migrations. (EPG 0)
May 26, 2024 08:28:45.659 [140025076947768] INFO - [CERT/OCSP] Successfully retrieved response.
May 26, 2024 08:28:45.920 [140025084340880] INFO - Running migrations. (EPG 0)
May 26, 2024 08:28:45.921 [140025076947768] INFO - Preemptively preparing driver imd for GPU JasperLake [UHD Graphics]
May 26, 2024 08:28:45.922 [140025076947768] INFO - Preemptively preparing driver icr for GPU JasperLake [UHD Graphics]
May 26, 2024 08:28:48.615 [140025048783672] INFO - Refreshing paths watched by LibraryUpdateManager
May 26, 2024 08:28:49.837 [140025072663352] WARN - [EventSourceClient/pubsub/192.81.131.80:443] MyPlex: attempted a reachability check but we're not yet mapped.
May 26, 2024 08:28:59.198 [140025072663352] WARN - [CERT] TLS connection from [::ffff:192.168.1.22]:41548 came in with unrecognized plex.direct SNI name '192-168-1-22.b349a2c1e12449319a1bd097b21decf7.plex.direct'; using installed plex.direct cert
May 26, 2024 08:28:59.218 [140025074772792] WARN - [CERT] TLS connection from [::ffff:192.168.1.22]:48900 came in with unrecognized plex.direct SNI name '10-0-5-1.b349a2c1e12449319a1bd097b21decf7.plex.direct'; using installed plex.direct cert
May 26, 2024 08:28:59.237 [140025072663352] WARN - [CERT] TLS connection from [::ffff:192.168.1.22]:38738 came in with unrecognized plex.direct SNI name '10-0-3-1.b349a2c1e12449319a1bd097b21decf7.plex.direct'; using installed plex.direct cert
May 26, 2024 08:28:59.257 [140025074772792] WARN - [CERT] TLS connection from [::ffff:192.168.1.22]:46426 came in with unrecognized plex.direct SNI name '10-0-7-1.b349a2c1e12449319a1bd097b21decf7.plex.direct'; using installed plex.direct cert
May 26, 2024 08:28:59.267 [140025061833528] WARN - [HttpClient/HCl#29] HTTP error requesting GET https://192-168-1-22.b349a2c1e12449319a1bd097b21decf7.plex.direct:32400 (60, SSL peer certificate or SSH remote key was not OK) (SSL: no alternative certificate subject name matches target host name '192-168-1-22.b349a2c1e12449319a1bd097b21decf7.plex.direct')
May 26, 2024 08:28:59.267 [140025061833528] WARN - [HttpClient/HCl#2a] HTTP error requesting GET https://10-0-5-1.b349a2c1e12449319a1bd097b21decf7.plex.direct:32400 (60, SSL peer certificate or SSH remote key was not OK) (SSL: no alternative certificate subject name matches target host name '10-0-5-1.b349a2c1e12449319a1bd097b21decf7.plex.direct')
May 26, 2024 08:28:59.267 [140025061833528] WARN - [HttpClient/HCl#2b] HTTP error requesting GET https://10-0-3-1.b349a2c1e12449319a1bd097b21decf7.plex.direct:32400 (60, SSL peer certificate or SSH remote key was not OK) (SSL: no alternative certificate subject name matches target host name '10-0-3-1.b349a2c1e12449319a1bd097b21decf7.plex.direct')
May 26, 2024 08:28:59.267 [140025061833528] WARN - [HttpClient/HCl#2c] HTTP error requesting GET https://10-0-7-1.b349a2c1e12449319a1bd097b21decf7.plex.direct:32400 (60, SSL peer certificate or SSH remote key was not OK) (SSL: no alternative certificate subject name matches target host name '10-0-7-1.b349a2c1e12449319a1bd097b21decf7.plex.direct')
May 26, 2024 08:28:59.267 [140025003141944] WARN - Connection Tester: Error testing media server RicoFlix in 88 ms.
May 26, 2024 08:29:01.562 [140025042578232] WARN - NAT: PMP, got an error: Not Supported by gateway.
May 26, 2024 08:29:13.372 [140025079577400] WARN - JobManager: Could not find job for handle 9788
May 26, 2024 08:29:13.377 [140025079577400] WARN - JobManager: Could not find job for handle 9419

But the time stamp is earlier than the time stamp for the database repair tool above.
Thank you.

Thanks for sharing that … I’m already seeing a couple problems there.

  1. You have IPv6 enabled on an IPv4-only LAN.

  2. CURL error 60 — Whose certificate have you installed? The one from QNAP?

Let’s find out more about why it’s complaining.

  1. SSH into the QNAP
  2. Plex is still in the enabled but unable to start state.
  3. with the ‘#’ prompt showing (login as ‘admin’ or ‘sudo’ –

/etc/init.d/plex.sh start

  1. If it’s going to spit errors, you’ll see them here.
  2. Highlight and Copy all that text
  3. Return here ane paste it into a </> (pre-formatted) block to prevent the forum from eating it.
/share/homes/rcrdcanepa$ sudo /etc/init.d/plex.sh start
PlexMediaServer is disabled.
/share/homes/rcrdcanepa$ 

The certificate is from myqnapcloud. It did expire yesterday, and I reissued it.
I am not sure why the certificates are only valid for a month:
CN: [hostname].myqnapcloud.com
Issued On Sunday, May 26, 2024 at 12:49:56 PM
Expires On Saturday, August 24, 2024 at 12:49:55 PM

Please let me know if I used the pre-formated form correctly.
Thank you.

Try doing the preformatted this way. It might be easier.

type:

``` (grave – left of the “1” key)
now paste your text
``` (one more time to close the block

it looks like this:

now paste your text

This is how I get into the OS and share info with folks. e.g

[   96.805383] md/raid:md321: report qnap hal event: raid_id=321, pd_name=/dev/(null), spare=/dev/(null), pd_repair_sector=0
[  106.847326] EXT4-fs (dm-2): Mount option "noacl" will be removed by 3.5
[  106.847326] Contact linux-ext4@vger.kernel.org if you think we should keep it.
[  106.847326] 
[  119.796041] ext4_init_reserve_inode_table0: dm-2, 1041426
[  119.801461] ext4_init_reserve_inode_table2: dm-2, 1041426, 0, 0, 4096
[  119.863044] EXT4-fs (dm-2): mounted filesystem (DataVol2) with ordered data mode. Opts: usrjquota=aquota.user,jqfmt=vfsv1,user_xattr,data=ordered,data_err=abort,delalloc,nopriv,nodiscard,noacl
[  120.677050] EXT4-fs (dm-4): Mount option "noacl" will be removed by 3.5
[  120.677050] Contact linux-ext4@vger.kernel.org if you think we should keep it.
[  120.677050] 
[  120.779804] ext4_init_reserve_inode_table0: dm-4, 3613
[  120.784981] ext4_init_reserve_inode_table2: dm-4, 3613, 0, 0, 4096

I edited my previous post with <pre></pre>. Was that would you wanted?

No… <pre> and </pre>

Don’t work in this forum

when you click the </> you get pair of ``` to put your text in.

If you look, the <pre> block just eats everything.

One more try if you please :slight_smile:

I am very sorry. Let’s try again:

/share/homes/rcrdcanepa$ sudo /etc/init.d/plex.sh start
PlexMediaServer is disabled.
/share/homes/rcrdcanepa$ 

AH! Start Plex in AppCenter…
Let it fail.
Then go to the SSH window.

This is the kind of output I’m looking for

[~] # ps -ef | grep -i plex
19391 admin       468 S   grep -i plex
25133 admin     20976 S N /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Plex Media Server
25363 admin     30376 S N Plex Plug-in [com.plexapp.system] /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-22bf56181/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.32.5.7186-22bf56181 /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-22bf56181/System.bundle
27516 admin      2572 S N /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Plex Tuner Service /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Tuner/Private /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Tuner/Shared 1.32.5.7186-22bf56181 32600
27559 admin     32948 S N Plex Plug-in [com.plexapp.agents.imdb] /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-22bf56181/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.32.5.7186-22bf56181 /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-22bf56181/PlexMovie.bundle
[~] # 
[~] # 
[~] # /etc/init.d/plex.sh stop
Stopping Plex Media Server...
[~] # /etc/init.d/plex.sh start
Starting Plex Media Server...
[~] # 

You should get some crazy stuff after starting PMS.

From the QNAP Event Logs after starting PMS on the App Center:

[App Center] Started Plex Media Server.
Information	2024-05-26	11:08:56	---	---	localhost	---	---	---	Starting Plex Media Server...

/share/homes/rcrdcanepa$ sudo /etc/init.d/plex.sh start
Password:
Plex Media Server is currently running or hasn’t been shutdown properly. Please stop it from QNAP AppCenter and start it again.
/share/homes/rcrdcanepa$

Thanks. Now it’s making sense.

  1. It thinks it’s still disabled. (prevented from starting)
  2. Unforunately, time to restart the NAS
    – Get everything up to date with the updated cert
  3. After restart , Start Plex from App Center.

If you’ve already done this, we might best make private arrangements.

Yes, certificate is up to date, for a least 30 days. I have rebooted the NAS a few times already, and at least once after I used the database repair tool and the certificate was updated.
In any case, I will reboot the NAS one more time.

please go into the ssh, get over to /share/*/.qpkg/Ple*/Li*/Ple* :wink:
and tar cfz /share/Public/PlexLogs.tar.gz ./Logs

Then, from the Public share, download and attach that gz please.

Here is the tar file. Thanks,

PlexLogs.tar.gz (47.8 KB)

Sorry for the delay,

You turned DEBUG logging OFF. I can’t see anything.

While in the SSH command line, We need to edit Preferences.xml.
Specifically adding the LogDebug="1" preference

You can use your favorite text editor (vi, nano, etc) --OR–

sed -i 's;/>; LogDebug="1"/>;' ./Preferences.xml

Then start Plex again.
After it tries to start, it’ll print DEBUG logging and I’ll be able to see more in the logs.

Gather a fresh .tar.gz , download, and attach again please.

Here is the new tar file. Thanks,

PlexLogs.tar.gz (51.6 KB)

That is the same as before. Debug logging did not enable.

If you cat Preferences.xml , it should look like this at the end.

PubSubServerPing="105" AcceptedEULA="1" PublishServerOnPlexOnlineKey="0" CertificateUUID="4f14d359f8654c01902593d04bd6dffe" LogDebug="1"/>
[/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex Media Server] # 

My Prefences.xml file looks very different. But, I can see two instances of the LogDebug:
logDebug=“0” and LogDebug=“1”
So, I will remove the logDebug=“0” and try again. Let me know if this does not work for you.
Thanks,

And here is the tar file, hopefully with debug enabled:

PlexLogs.tar.gz (72.7 KB)

BTW, should this URL work also?

http://[PMS-local-IP]:32400/web/index.html

It does not work.
Thanks,