Sync failing on QNAP NAS

Server Version#: 1.18.1.1973

I seem to be unable to sync ‘tvshows’ onto either an iOS or Android device.

I’ve created a temp tvshow library and have the same issue. Films are fine.

Looking in the logs, I get:

Oct 18, 2019 13:20:01.989 [0x7fa3d99e9700] Error — Exception inside transaction (inside=1) (../Library/MetadataItem.cpp:779): Null value fetched and no indicator defined.

Oct 18, 2019 13:20:01.989 [0x7fa3d99e9700] Error — Thread: Uncaught exception running async task which was spawned by thread 0x7fa3bd11f700: Null value fetched and no indicator defined.

This old post explains the exact issue I have Sync failing PMS 1.17.0 however there are no comments to say how it was resolved (if it was).

Same issue, could only sync movies. Music and tv failed, and the only fix was a fresh database unfortunately

Did you want to upload your log files? I’ll test this on my QNAP in a few hours.
Thanks

TV is slow to start syncing. Movies are instant-start.
Continuing to investigate

Works okay here. I was able to sync two tv episodes in different formats.
One was an xvid avi that went to the iPad at Highest without conversion.
The other was an x264 mkv that got burned subtitles.

Server - 1.18.1.1973 on x64 QNAP QTS 4.3.6-1070
Player - 6.2 on a 2018 iPad running iOS 13.1.3

Then I went offline and played both episodes. I’ll try another device.

Plex Media Server.log
com.plexapp.system.log
Plex Media Scanner Analysis.log

I’m running PMS on a QNAP TS1277 QTS 4.4.1.1086

I don’t think it is an issue with PMS in general, but something to do with my instance of it. As @M1dKn1ght says, maybe a db issue?
I just find it strange it only effects libraries which are ‘TV programmes’. Even new libraries.

Thanks for those logs but unfortunately they aren’t useful.

  1. Turn DEBUG logging on
  2. Keep VERBOSE logging off.
  3. Recreate the problem
  4. Wait 30 seconds
  5. Settings - Server - Troubleshooting - Download Logs
  6. Attach the entire ZIP file

Thanks:

Plex Media Server Logs_2019-10-20_16-50-09.zip (188.5 KB)

Okay so you’re running:

Oct 20, 2019 13:20:52.643 [0x7fc2c7f5b700] INFO - Plex Media Server v1.18.1.1973-0f4abfbcc - QNAP TS-1277 x86_64 - build: linux-x86_64 qnap - GMT 01:00
Oct 20, 2019 13:20:52.643 [0x7fc2c7f5b700] INFO - Linux version: QTS 4.4.1.1086, language: en-US
Oct 20, 2019 13:20:52.643 [0x7fc2c7f5b700] INFO - Processor AMD Ryzen 7 PRO 1700 Eight-Core Processor

Did you have the problem with QTS 4.3.6-1070?

The logs are chaotic and filled with errors like in your first post. @M1dKn1ght said the fix was a fresh database, and it does look database related but not in the usual way. The more common symptom of a db problem is an SQLITE3 error saying “database corruption” or something similar. Your logs have no ERRORs from SQLITE3 at least. The topic of checking is covered in https://support.plex.tv/articles/201100678-repair-a-corrupt-database/

One repeated problem that can be stopped temporarily is to identify and unplug this device if it’s not mandatory during testing, because your logs are filled with this error too:

Oct 20, 2019 13:23:06.192 [0x7fc2bcaf4700] ERROR - SSDP: Error parsing device schema for http://10.10.10.103:55296/

I would like to see the logs covering a PMS start.
I would reboot the QNAP and grab logs 6 min. after it’s back to a desktop,
but you’ll want to wait and see what ChuckPA asks you to do first. Good luck!

Please turn DEBUG logging ON again. Default is ON. ON or OFF makes no difference in space utilized (50 MB total).

We cannot see what PMS is trying to do if only WARN, INFO, or ERROR messages show.

Please enable debug logging,
Restart PMS
Recreate the problem
Download and attach a fresh set of ZIP logs

restarted PMS at 20:03

Plex Media Server Logs_2019-10-20_20-07-01.zip (923.5 KB)

  1. You might want to identify the network domain. PMS is treating it as Non-Local even though it’s on the same subnet. (Settings - Server - Network - Show Advanced)

  2. I see where the client app closed the connection.

Oct 20, 2019 20:06:40.425 [0x7ff0ab159700] DEBUG - Content-Length is -1 (of total: -1).
Oct 20, 2019 20:07:00.425 [0x7ff14b8c8700] DEBUG - Completed: [10.10.10.171:53348] 200 GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (12 live) TLS GZIP 20000ms 5 bytes (pipelined: 20)
Oct 20, 2019 20:07:00.480 [0x7ff14b5da700] DEBUG - WebSocket: client initiated close
Oct 20, 2019 20:07:00.481 [0x7ff14b5da700] DEBUG - NotificationStream: Removing because of close
Oct 20, 2019 20:07:00.486 [0x7ff14b8c8700] DEBUG - handleStreamRead code 2: End of file

Thats the IP of the computer I’m using not the device I’m syncing to so it shouldn’t matter.

I’ve decided to start afresh as it seems something has gone wrong with the DB but SQLite3 is not reporting a corrupt DB (as per https://support.plex.tv/articles/201100678-repair-a-corrupt-database/)

I’ve stopped PMS
removed the com.plexapp.plugins.library.db
started PMS
added my libraries back and waiting for all the metadata to finish downloading
stopped PMS
followed https://support.plex.tv/articles/201154527-move-viewstate-ratings-from-one-install-to-another/ to get my view history into the new PMS DB
started PMS

I’m now able to sync both ‘films’ and ‘tv’.

I can’t work out where the ‘On Deck’ is stored in the DB as I would be nice to have that also.

I did follow that for the watch history however it didn’t copy the ‘On Deck’ watch list.

I’ve just played/unplayed several shows to get them on the On Deck.

Hey that’s great news you’re up and running again.
I noticed some creative networking

on the QNAP
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG - Detected primary interface: 10.10.10.240
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG - Network interfaces:
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG -  * 1 lo (127.0.0.1) (loopback: 1)
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG -  * 3 eth1 (10.10.10.11) (loopback: 0)
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG -  * 4 eth2 (10.10.10.240) (loopback: 0)
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG -  * 11 docker0 (10.0.5.1) (loopback: 0)
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG -  * 12 lxcbr0 (10.0.3.1) (loopback: 0)
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG -  * 13 qvs0 (10.10.10.10) (loopback: 0)
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG - Creating NetworkServices singleton.
Oct 20, 2019 20:03:14.010 [0x7ff15ce10740] DEBUG - NetworkService: Creating new service.

I’m curious if those turn out to have any affect on Plex. Which NIC is the QNAP default gateway?

default is eth0/qvs0 (10.10.10.10) however the QNAP can be accessed from x.11 and x.240. Strange the log says x.240 is primary

eth0/qvs0 is also a virtual switch for containers and VMs. (assume that is why it is displayed as qvs and not eth)

I’ve never had any issue accessing PMS itself either LAN or WAN. My unifi switch looks after STP etc.

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