PlexKodiConnect/resources/lib/library_sync/full_sync.py

430 lines
18 KiB
Python
Raw Normal View History

2018-10-20 23:49:04 +11:00
#!/usr/bin/env python
# -*- coding: utf-8 -*-
from __future__ import absolute_import, division, unicode_literals
from logging import getLogger
import Queue
import copy
2018-12-09 23:02:08 +11:00
import xbmcgui
from cProfile import Profile
from pstats import Stats
from StringIO import StringIO
2018-10-20 23:49:04 +11:00
from .get_metadata import GetMetadataTask, reset_collections
from . import common, sections
2018-11-19 00:59:17 +11:00
from .. import utils, timing, backgroundthread, variables as v, app
2018-10-20 23:49:04 +11:00
from .. import plex_functions as PF, itemtypes
2018-10-23 22:54:09 +11:00
from ..plex_db import PlexDB
2018-10-20 23:49:04 +11:00
2018-10-23 22:54:09 +11:00
if (v.PLATFORM != 'Microsoft UWP' and
utils.settings('enablePlaylistSync') == 'true'):
# Xbox cannot use watchdog, a dependency for PKC playlist features
from .. import playlists
PLAYLIST_SYNC_ENABLED = True
else:
PLAYLIST_SYNC_ENABLED = False
2018-10-20 23:49:04 +11:00
2018-11-02 01:43:43 +11:00
LOG = getLogger('PLEX.sync.full_sync')
2018-12-09 23:02:08 +11:00
# How many items will be put through the processing chain at once?
BATCH_SIZE = 2000
# Safety margin to filter PMS items - how many seconds to look into the past?
UPDATED_AT_SAFETY = 60 * 5
LAST_VIEWED_AT_SAFETY = 60 * 5
def tag_last(iterable):
"""
Given some iterable, returns (last, item), where last is only True if you
are on the final iteration.
"""
iterator = iter(iterable)
gotone = False
try:
lookback = next(iterator)
gotone = True
while True:
cur = next(iterator)
yield False, lookback
lookback = cur
except StopIteration:
if gotone:
yield True, lookback
raise StopIteration()
class InitNewSection(object):
"""
Throw this into the queue used for ProcessMetadata to tell it which
Plex library section we're looking at
"""
def __init__(self, context, total_number_of_items, section_name,
section_id, plex_type):
self.context = context
self.total = total_number_of_items
self.name = section_name
self.id = section_id
self.plex_type = plex_type
2018-10-20 23:49:04 +11:00
class FullSync(common.libsync_mixin):
2018-10-24 16:08:32 +11:00
def __init__(self, repair, callback, show_dialog):
2018-10-20 23:49:04 +11:00
"""
repair=True: force sync EVERY item
"""
self._canceled = False
2018-10-20 23:49:04 +11:00
self.repair = repair
self.callback = callback
2018-10-21 21:03:21 +11:00
self.queue = None
self.process_thread = None
2018-11-05 02:53:42 +11:00
self.current_sync = None
2018-10-29 02:14:37 +11:00
self.plexdb = None
2018-10-22 01:56:13 +11:00
self.plex_type = None
2018-11-05 02:53:42 +11:00
self.section_type = None
2018-12-09 23:02:08 +11:00
self.worker_count = int(utils.settings('syncThreadNumber'))
self.item_count = 0
# For progress dialog
self.show_dialog = show_dialog
self.show_dialog_userdata = utils.settings('playstate_sync_indicator') == 'true'
self.dialog = None
self.total = 0
self.current = 0
2018-12-09 23:02:08 +11:00
self.processed = 0
self.title = ''
self.section = None
self.section_name = None
2018-10-25 22:27:12 +11:00
self.install_sync_done = utils.settings('SyncInstallRunDone') == 'true'
self.threader = backgroundthread.ThreaderManager(
2018-12-09 23:02:08 +11:00
worker=backgroundthread.NonstoppingBackgroundWorker,
worker_count=self.worker_count)
2018-10-20 23:49:04 +11:00
super(FullSync, self).__init__()
2018-12-09 23:02:08 +11:00
def update_progressbar(self):
if self.show_dialog:
try:
progress = int(float(self.current) / float(self.total) * 100.0)
except ZeroDivisionError:
progress = 0
self.dialog.update(progress,
'%s (%s)' % (self.section_name, self.section_type_text),
'%s/%s %s'
% (self.current, self.total, self.title))
2018-10-22 01:56:13 +11:00
def process_item(self, xml_item):
2018-10-20 23:49:04 +11:00
"""
Processes a single library item
"""
2018-10-26 00:57:12 +11:00
plex_id = int(xml_item.get('ratingKey'))
2018-11-05 02:53:42 +11:00
if not self.repair and self.plexdb.checksum(plex_id, self.plex_type) == \
int('%s%s' % (plex_id,
xml_item.get('updatedAt',
xml_item.get('addedAt', 1541572987)))):
2018-11-05 02:53:42 +11:00
return
2018-12-09 23:02:08 +11:00
self.threader.addTask(GetMetadataTask(self.queue,
plex_id,
self.plex_type,
self.get_children))
self.item_count += 1
2018-10-20 23:49:04 +11:00
2018-12-09 23:02:08 +11:00
def process_playstate(self, xml_item):
2018-10-22 01:56:13 +11:00
"""
2018-12-09 23:02:08 +11:00
Processes the playstate of a single library item
2018-10-22 01:56:13 +11:00
"""
2018-12-09 23:02:08 +11:00
plex_id = int(xml_item.get('ratingKey'))
if not self.repair and self.plexdb.checksum(plex_id, self.plex_type) == \
int('%s%s' % (plex_id,
xml_item.get('updatedAt',
xml_item.get('addedAt', 1541572987)))):
return
self.threader.addTask(GetMetadataTask(self.queue,
plex_id,
self.plex_type,
self.get_children))
self.item_count += 1
def update_library(self):
LOG.debug('Writing changes to Kodi library now')
i = 0
if not self.section:
self.section = self.queue.get()
self.queue.task_done()
while not self.isCanceled() and self.item_count > 0:
section = self.section
if not section:
break
LOG.debug('Start or continue processing section %s (%ss)',
section.name, section.plex_type)
self.processed = 0
self.total = section.total
self.section_name = section.name
self.section_type_text = utils.lang(
v.TRANSLATION_FROM_PLEXTYPE[section.plex_type])
with section.context(self.current_sync) as context:
while not self.isCanceled() and self.item_count > 0:
try:
item = self.queue.get(block=False)
except backgroundthread.Queue.Empty:
if self.threader.threader.working():
app.APP.monitor.waitForAbort(0.02)
continue
else:
# Try again, in case a thread just finished
i += 1
if i == 3:
break
continue
i = 0
self.queue.task_done()
if isinstance(item, dict):
context.add_update(item['xml'][0],
section_name=section.name,
section_id=section.id,
children=item['children'])
self.title = item['xml'][0].get('title')
self.processed += 1
elif isinstance(item, InitNewSection) or item is None:
self.section = item
break
else:
raise ValueError('Unknown type %s' % type(item))
self.item_count -= 1
self.current += 1
self.update_progressbar()
2018-12-09 23:02:08 +11:00
if self.processed == 500:
self.processed = 0
context.commit()
LOG.debug('Done writing changes to Kodi library')
2018-10-22 01:56:13 +11:00
2018-10-21 21:03:21 +11:00
@utils.log_time
2018-12-09 23:02:08 +11:00
def addupdate_section(self, section):
LOG.debug('Processing library section for new or changed items %s',
section)
if not self.install_sync_done:
app.SYNC.path_verified = False
try:
# Sync new, updated and deleted items
2018-12-02 20:13:27 +11:00
iterator = section['iterator']
# Tell the processing thread about this new section
queue_info = InitNewSection(section['context'],
iterator.total,
iterator.get('librarySectionTitle'),
section['section_id'],
section['plex_type'])
self.queue.put(queue_info)
2018-12-09 23:02:08 +11:00
last = True
# To keep track of the item-number in order to kill while loops
self.item_count = 0
self.current = 0
2018-12-09 23:02:08 +11:00
while True:
# Check Plex DB to see what we need to add/update
with PlexDB() as self.plexdb:
for i, (last, xml_item) in enumerate(tag_last(iterator)):
if self.isCanceled():
return False
self.process_item(xml_item)
if self.item_count == BATCH_SIZE:
break
# Make sure Plex DB above is closed before adding/updating
if self.item_count == BATCH_SIZE:
self.update_library()
if last:
break
self.update_library()
reset_collections()
return True
except RuntimeError:
LOG.error('Could not entirely process section %s', section)
return False
2018-12-09 23:02:08 +11:00
@utils.log_time
def playstate_per_section(self, section):
LOG.debug('Processing playstate for library section %s', section)
try:
2018-12-09 23:02:08 +11:00
# Sync new, updated and deleted items
iterator = section['iterator']
# Tell the processing thread about this new section
queue_info = InitNewSection(section['context'],
iterator.total,
2018-12-09 23:02:08 +11:00
section['section_name'],
section['section_id'],
section['plex_type'])
self.queue.put(queue_info)
2018-12-09 23:02:08 +11:00
self.total = iterator.total
self.section_name = section['section_name']
self.section_type_text = utils.lang(
v.TRANSLATION_FROM_PLEXTYPE[section['plex_type']])
self.current = 0
with section['context'](self.current_sync) as itemtype:
for xml_item in iterator:
if self.isCanceled():
return False
itemtype.update_userdata(xml_item, section['plex_type'])
itemtype.plexdb.update_last_sync(int(xml_item.attrib['ratingKey']),
section['plex_type'],
self.current_sync)
self.current += 1
self.update_progressbar()
return True
except RuntimeError:
2018-12-09 23:02:08 +11:00
LOG.error('Could not entirely process section %s', section)
return False
2018-12-09 23:02:08 +11:00
def threaded_get_iterators(self, kinds, queue, updated_at=None,
last_viewed_at=None):
2018-10-20 23:49:04 +11:00
"""
PF.SectionItems is costly, so let's do it asynchronous
2018-10-20 23:49:04 +11:00
"""
2018-12-09 23:02:08 +11:00
if self.repair:
updated_at = None
last_viewed_at = None
else:
updated_at = updated_at - UPDATED_AT_SAFETY if updated_at else None
last_viewed_at = last_viewed_at - LAST_VIEWED_AT_SAFETY \
if last_viewed_at else None
try:
for kind in kinds:
for section in (x for x in sections.SECTIONS
if x['plex_type'] == kind[1]):
if self.isCanceled():
return
element = copy.deepcopy(section)
element['section_type'] = element['plex_type']
element['plex_type'] = kind[0]
element['element_type'] = kind[1]
element['context'] = kind[2]
element['get_children'] = kind[3]
2018-12-02 20:13:27 +11:00
element['iterator'] = PF.SectionItems(section['section_id'],
2018-12-09 23:02:08 +11:00
plex_type=kind[0],
updated_at=updated_at,
last_viewed_at=last_viewed_at)
queue.put(element)
finally:
queue.put(None)
2018-10-20 23:49:04 +11:00
2018-10-22 01:56:13 +11:00
def full_library_sync(self):
2018-10-20 23:49:04 +11:00
"""
"""
2018-10-21 21:03:21 +11:00
kinds = [
2018-11-05 02:53:42 +11:00
(v.PLEX_TYPE_MOVIE, v.PLEX_TYPE_MOVIE, itemtypes.Movie, False),
(v.PLEX_TYPE_SHOW, v.PLEX_TYPE_SHOW, itemtypes.Show, False),
(v.PLEX_TYPE_SEASON, v.PLEX_TYPE_SHOW, itemtypes.Season, False),
(v.PLEX_TYPE_EPISODE, v.PLEX_TYPE_SHOW, itemtypes.Episode, False)
2018-10-21 21:03:21 +11:00
]
2018-11-19 00:59:17 +11:00
if app.SYNC.enable_music:
2018-10-25 22:22:34 +11:00
kinds.extend([
2018-11-05 02:53:42 +11:00
(v.PLEX_TYPE_ARTIST, v.PLEX_TYPE_ARTIST, itemtypes.Artist, False),
(v.PLEX_TYPE_ALBUM, v.PLEX_TYPE_ARTIST, itemtypes.Album, True),
2018-11-04 04:47:51 +11:00
])
2018-12-09 23:02:08 +11:00
# ADD NEW ITEMS
# Already start setting up the iterators. We need to enforce
# syncing e.g. show before season before episode
2018-12-09 23:02:08 +11:00
if not self.show_dialog_userdata and self.dialog:
# Close the progress indicator dialog
self.dialog.close()
self.dialog = None
iterator_queue = Queue.Queue()
2018-12-09 23:02:08 +11:00
updated_at = int(utils.settings('lastfullsync')) or None
task = backgroundthread.FunctionAsTask(self.threaded_get_iterators,
None,
kinds,
2018-12-09 23:02:08 +11:00
iterator_queue,
updated_at=updated_at)
backgroundthread.BGThreader.addTask(task)
while True:
section = iterator_queue.get()
2018-12-09 23:02:08 +11:00
iterator_queue.task_done()
if section is None:
break
# Setup our variables
self.plex_type = section['plex_type']
self.section_type = section['section_type']
self.context = section['context']
self.get_children = section['get_children']
# Now do the heavy lifting
2018-12-09 23:02:08 +11:00
if self.isCanceled() or not self.addupdate_section(section):
return False
2018-12-09 23:02:08 +11:00
# SYNC PLAYSTATE of ALL items (otherwise we won't pick up on items that
# were set to unwatched). Also mark all items on the PMS to be able
# to delete the ones still in Kodi
LOG.info('Start synching playstate and userdata for every item')
task = backgroundthread.FunctionAsTask(self.threaded_get_iterators,
None,
kinds,
iterator_queue)
backgroundthread.BGThreader.addTask(task)
while True:
section = iterator_queue.get()
iterator_queue.task_done()
2018-12-09 23:02:08 +11:00
if section is None:
break
# Setup our variables
self.plex_type = section['plex_type']
self.section_type = section['section_type']
self.context = section['context']
self.get_children = section['get_children']
# Now do the heavy lifting
if self.isCanceled() or not self.playstate_per_section(section):
return False
# Delete movies that are not on Plex anymore
LOG.info('Looking for items to delete')
with section['context'](self.current_sync) as context:
for plex_id in context.plexdb.plex_id_by_last_sync(self.plex_type,
self.current_sync):
if self.isCanceled():
return False
context.remove(plex_id, self.plex_type)
LOG.debug('Done deleting')
2018-10-20 23:49:04 +11:00
return True
@utils.log_time
def run(self):
profile = Profile()
profile.enable()
2018-12-09 23:02:08 +11:00
self.current_sync = timing.plex_now()
2018-10-24 16:08:32 +11:00
# Delete playlist and video node files from Kodi
utils.delete_playlists()
utils.delete_nodes()
# Get latest Plex libraries and build playlist and video node files
2018-10-22 03:32:11 +11:00
if not sections.sync_from_pms():
return
2018-12-09 23:02:08 +11:00
successful = False
2018-10-20 23:49:04 +11:00
try:
2018-12-09 23:02:08 +11:00
self.queue = backgroundthread.Queue.Queue()
if self.show_dialog:
self.dialog = xbmcgui.DialogProgressBG()
self.dialog.create(utils.lang(39714))
2018-10-23 22:54:09 +11:00
# Actual syncing - do only new items first
2018-11-05 02:53:42 +11:00
LOG.info('Running full_library_sync with repair=%s',
2018-10-23 22:54:09 +11:00
self.repair)
2018-10-20 23:49:04 +11:00
if not self.full_library_sync():
return
if self.isCanceled():
return
if PLAYLIST_SYNC_ENABLED and not playlists.full_sync():
return
successful = True
finally:
common.update_kodi_library(video=True, music=True)
2018-12-09 23:02:08 +11:00
if self.dialog:
self.dialog.close()
self.threader.shutdown()
2018-12-09 23:02:08 +11:00
if successful:
utils.settings('lastfullsync', value=str(int(self.current_sync)))
2018-10-24 16:08:32 +11:00
if self.callback:
self.callback(successful)
2018-10-22 03:32:11 +11:00
LOG.info('Done full_sync')
profile.disable()
string_io = StringIO()
stats = Stats(profile, stream=string_io).sort_stats('cumulative')
stats.print_stats()
LOG.info('cProfile result: ')
LOG.info(string_io.getvalue())
2018-10-20 23:49:04 +11:00
2018-10-24 16:08:32 +11:00
def start(show_dialog, repair=False, callback=None):
2018-10-20 23:49:04 +11:00
"""
"""
# FullSync(repair, callback, show_dialog).start()
FullSync(repair, callback, show_dialog).run()