Watcher3
Watcher3 copied to clipboard
Published
20 hours ago •
barbequesauce
barbequesauce
Downloaded and processed movie still in Snatched status
trafficstars
Running in to a issue where some movies stay as snatched and never "Finish". All files have been processed into their correct folders, I've run the missing file scanner but it doesn't find anything wrong. I've manually added the location of each movie into their database entry but i still cant get it to register that the files are in their location. I'm sure i can just delete the movies from the database and import them but that's not ideal if you have to scan though a lot of files just to find a single or a few movies.
Here's the log output:
INFO [2020-01-14 16:43:17,582] core.ajax.get_log_text.569: Dumping log file log.txt to text. INFO [2020-01-14 16:43:07,665] CPTaskScheduler._task.273: == Finished Task: Missing Files Scan == INFO [2020-01-14 16:43:07,444] CPTaskScheduler._task.248: == Executing Task: Missing Files Scan Per User Command == INFO [2020-01-14 16:43:07,444] core.ajax.manual_task_execute.1411: Manually executing task Missing Files Scan. INFO [2020-01-14 16:40:54,379] core.ajax.get_log_text.569: Dumping log file log.txt to text. INFO [2020-01-14 16:40:42,249] CPTaskScheduler._task.273: == Finished Task: Missing Files Scan == INFO [2020-01-14 16:40:42,085] core.library.scanmissingfiles.761: File /media/DrivePool/Movie/The Notebook (2004)/The Notebook(2004).mkv is missing for movie The Notebook INFO [2020-01-14 16:40:41,956] CPTaskScheduler._task.248: == Executing Task: Missing Files Scan Per User Command == INFO [2020-01-14 16:40:41,955] core.ajax.manual_task_execute.1411: Manually executing task Missing Files Scan.
I think these logs are not relevant, missing files scan looks for movies deleted from collection, to change to wanted or delete them from DB, depending on "If Movie File is Missing:" setting.
If movie is not detected as finished, even when file has been processed, we would need logs when file was processed to find why status didn't change to finished.
About setting location in library manage, you don't need to do it, and setting location doesn't change status. You should change status from Automatic to Finished, you can set location if you want to have watcher detecting if movie file is deleted, or have watcher to delete movie file when movie is deleted in watcher.
I've been going though my logs trying to find a good example of this issue, its intermittent. I do have another issue but ill make a new issue for that. Ill keep you posted as i watch the logs and wait for the bug to show again.
Here's some output from my NzbToMedia script running back to Watcher
[05:20:32] [INFO]::MAIN: Loading config from [/home/sab/scripts/nzbToMedia/autoProcessMedia.cfg]
[05:20:32] [INFO]::MAIN: Python v3.6 will reach end of life in 666 days.
[05:20:32] [INFO]::MAIN: Checking database structure...
[05:20:32] [INFO]::MAIN: Checking if git needs an update
[05:20:32] [ERROR]::MAIN: Unable to contact github, can't check for update
[05:20:32] [INFO]::MAIN: No update needed
[05:20:32] [INFO]::MAIN: nzbToMedia Version:2e7d4a58633b4b7924496ba849636bd5bb3b98cc Branch:master (Linux 4.15.0-88-generic)
[05:20:32] [INFO]::MAIN: #########################################################
[05:20:32] [INFO]::MAIN: ## ..::[nzbToMedia.py]::.. ##
[05:20:32] [INFO]::MAIN: #########################################################
[05:20:32] [INFO]::MAIN: Script triggered from SABnzbd 0.7.17+
[05:20:32] [INFO]::MAIN: Auto-detected SECTION:Watcher3
[05:20:32] [INFO]::MAIN: Calling Watcher3:movies to post-process:Hidden.Figures.2016.1080p.BluRay.DTS-ES.x264-NCmt.nzb
[05:20:32] [INFO]::MAIN: Attemping imdbID lookup for Hidden.Figures.2016.1080p.BluRay.DTS-ES.x264-NCmt.nzb
[05:20:32] [INFO]::MAIN: Searching folder and file names for imdbID ...
[05:20:32] [INFO]::MAIN: Searching IMDB for imdbID ...
[05:20:32] [INFO]::MAIN: Unable to determine imdbID: No api key provided for ombdapi.com.
[05:20:34] [INFO]::TRANSCODER: Checking [Hidden.Figures.2016.1080p.BluRay.DTS-ES.x264-NCmt.English.mkv] for corruption, please stand by ...
[05:20:34] [INFO]::TRANSCODER: SUCCESS: [Hidden.Figures.2016.1080p.BluRay.DTS-ES.x264-NCmt.English.mkv] has no corruption.
[05:20:34] [POSTPROCESS]::WATCHER3: Starting postprocessing scan for Hidden.Figures.2016.1080p.BluRay.DTS-ES.x264-NCmt.nzb
Changing to directory: /home/sab/scripts/nzbToMedia
-- Cleaning bytecode --
b'Removing __pycache__/\n'
b'Removing __pycache__/\n'
-- Cleaning folders: ['libs', 'core'] --
No folders to clean
Returning to directory: /usr/bin
-- Cleanup finished --
Traceback (most recent call last):
File "/home/sab/scripts/nzbToMedia/nzbToWatcher3.py", line 267, in <module>
result = nzbToMedia.main(sys.argv, section)
File "/home/sab/scripts/nzbToMedia/nzbToMedia.py", line 990, in main
download_id='', failure_link=''.join(args[8:]))
File "/home/sab/scripts/nzbToMedia/nzbToMedia.py", line 851, in process
result = movies.process(section_name, input_directory, input_name, status, client_agent, download_id, input_category, failure_link)
File "/home/sab/scripts/nzbToMedia/core/auto_process/movies.py", line 260, in process
elif section == 'Watcher3' and result['status'] == 'finished':
KeyError: 'status'
And output from the Watcher log
INFO [2020-02-26 05:21:35,998] core.postprocessing.default.232: {
INFO [2020-02-26 05:21:35,998] core.postprocessing.default.231: Post-processing complete.
INFO [2020-02-26 05:21:35,998] core.postprocessing.default.230: #################################
DEBUG [2020-02-26 05:21:35,851] core.sqldb.execute.166: Executing SQL command: ['UPDATE MOVIES SET status=? WHERE imdbid=? COLLATE NOCASE', ('Snatched', 'tt6644200')]
DEBUG [2020-02-26 05:21:35,851] core.sqldb.update.250: Updating status to Snatched for rows that match imdbid:tt6644200 in MOVIES.
INFO [2020-02-26 05:21:35,851] core.library.movie_status.1085: Setting MOVIES tt6644200 status to Snatched.
DEBUG [2020-02-26 05:21:35,848] core.sqldb.execute.166: Executing SQL command: ['SELECT DISTINCT status FROM SEARCHRESULTS WHERE imdbid="tt6644200" AND (reject_reason IS NULL OR status <> "Available")AND type IN ("import", "nzb", "torrent", "magnet")']
DEBUG [2020-02-26 05:21:35,847] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM MOVIES WHERE imdbid="tt6644200"']
DEBUG [2020-02-26 05:21:35,847] core.sqldb.get_movie_details.439: Retrieving details for movie tt6644200.
INFO [2020-02-26 05:21:35,847] core.library.movie_status.1047: Determining appropriate status for movie tt6644200.
INFO [2020-02-26 05:21:35,847] core.library.markedresults.1027: Successfully created entry in MARKEDRESULTS for https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb.
DEBUG [2020-02-26 05:21:35,687] core.sqldb.execute.166: Executing SQL command: ['INSERT INTO MARKEDRESULTS ( imdbid, guid, status ) VALUES ( ?, ?, ? )', ['tt6644200', 'https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb', 'Snatched']]
DEBUG [2020-02-26 05:21:35,687] core.sqldb.write.193: Writing data to MARKEDRESULTS.
INFO [2020-02-26 05:21:35,687] core.library.markedresults.1020: Guid https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb not found in MARKEDRESULTS, creating entry.
DEBUG [2020-02-26 05:21:35,687] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM MARKEDRESULTS WHERE guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" COLLATE NOCASE']
DEBUG [2020-02-26 05:21:35,687] core.sqldb.row_exists.655: Checking if guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" exists in database table MARKEDRESULTS
INFO [2020-02-26 05:21:35,687] core.library.searchresults.969: Successfully marked https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Snatched in SEARCHRESULTS.
DEBUG [2020-02-26 05:21:35,510] core.sqldb.execute.166: Executing SQL command: ['UPDATE SEARCHRESULTS SET status=? WHERE guid=? COLLATE NOCASE', ('Snatched', 'https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb')]
DEBUG [2020-02-26 05:21:35,509] core.sqldb.update.250: Updating status to Snatched for rows that match guid:https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb in SEARCHRESULTS.
INFO [2020-02-26 05:21:35,509] core.library.searchresults.964: Marking https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Snatched in SEARCHRESULTS.
DEBUG [2020-02-26 05:21:35,506] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM SEARCHRESULTS WHERE guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" COLLATE NOCASE']
DEBUG [2020-02-26 05:21:35,506] core.sqldb.row_exists.655: Checking if guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" exists in database table SEARCHRESULTS
INFO [2020-02-26 05:21:35,506] core.library.searchresults.959: Marking guid https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Snatched.
INFO [2020-02-26 05:21:35,506] core.snatcher.update_status_snatched.287: Updating tt6644200 to Snatched.
DEBUG [2020-02-26 05:21:35,342] core.sqldb.execute.166: Executing SQL command: ['UPDATE SEARCHRESULTS SET downloadid=?,download_client=? WHERE guid=?', ('SABnzbd_nzo_7HJHcG', 'Sabnzbd', 'https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb')]
DEBUG [2020-02-26 05:21:35,342] core.sqldb.update_multiple_values.297: Updating guid:https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb to {'downloadid': 'SABnzbd_nzo_7HJHcG', 'download_client': 'Sabnzbd'} in SEARCHRESULTS.
INFO [2020-02-26 05:21:35,342] core.snatcher.snatch_nzb.216: Successfully sent A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P to Sabnzbd.
INFO [2020-02-26 05:21:35,342] core.downloaders.Sabnzbd.add_nzb.81: NZB sent to SABNzbd - downloadid SABnzbd_nzo_7HJHcG.
INFO [2020-02-26 05:21:35,335] core.downloaders.Sabnzbd.add_nzb.49: Sending NZB A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P to SABnzbd.
INFO [2020-02-26 05:21:35,335] core.snatcher.snatch_nzb.211: Sending nzb to Sabnzbd
INFO [2020-02-26 05:21:35,335] core.snatcher.download.164: Sending A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P to download client.
INFO [2020-02-26 05:21:35,335] core.snatcher.get_best_release.141: A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P is best available result for A Quiet Place
DEBUG [2020-02-26 05:21:35,331] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM SEARCHRESULTS WHERE imdbid="tt6644200" AND reject_reason IS NULL ORDER BY score DESC , CASE type WHEN "nzb" THEN 0\n WHEN "torrent" THEN 1\n WHEN "magnet" THEN 1\n END ASC\n , size DESC, freeleech DESC']
DEBUG [2020-02-26 05:21:35,331] core.sqldb.get_search_results.489: Retrieving Search Results for tt6644200.
INFO [2020-02-26 05:21:35,331] core.snatcher.get_best_release.89: Selecting best release for A Quiet Place
INFO [2020-02-26 05:21:35,331] core.postprocessing.failed.441: Grabbing the next best release.
DEBUG [2020-02-26 05:21:35,160] core.sqldb.execute.166: Executing SQL command: ['UPDATE MOVIES SET status=? WHERE imdbid=? COLLATE NOCASE', ('Found', 'tt6644200')]
DEBUG [2020-02-26 05:21:35,160] core.sqldb.update.250: Updating status to Found for rows that match imdbid:tt6644200 in MOVIES.
INFO [2020-02-26 05:21:35,160] core.library.movie_status.1085: Setting MOVIES tt6644200 status to Found.
DEBUG [2020-02-26 05:21:35,157] core.sqldb.execute.166: Executing SQL command: ['SELECT DISTINCT status FROM SEARCHRESULTS WHERE imdbid="tt6644200" AND (reject_reason IS NULL OR status <> "Available")AND type IN ("import", "nzb", "torrent", "magnet")']
DEBUG [2020-02-26 05:21:35,156] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM MOVIES WHERE imdbid="tt6644200"']
DEBUG [2020-02-26 05:21:35,156] core.sqldb.get_movie_details.439: Retrieving details for movie tt6644200.
INFO [2020-02-26 05:21:35,156] core.library.movie_status.1047: Determining appropriate status for movie tt6644200.
INFO [2020-02-26 05:21:35,156] core.postprocessing.failed.419: Setting MOVIE status.
INFO [2020-02-26 05:21:35,156] core.library.markedresults.1017: Successfully marked https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb as Bad in MARKEDRESULTS.
DEBUG [2020-02-26 05:21:34,990] core.sqldb.execute.166: Executing SQL command: ['UPDATE MARKEDRESULTS SET status=? WHERE guid=? COLLATE NOCASE', ('Bad', 'https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb&i=211318&r=42f28324b3b933d7d38e3560101f949a')]
DEBUG [2020-02-26 05:21:34,990] core.sqldb.update.250: Updating status to Bad for rows that match guid:https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb in MARKEDRESULTS.
INFO [2020-02-26 05:21:34,990] core.library.markedresults.1012: Marking https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb as Bad in MARKEDRESULTS.
DEBUG [2020-02-26 05:21:34,989] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM MARKEDRESULTS WHERE guid="https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb&i=211318&r=42f28324b3b933d7d38e3560101f949a" COLLATE NOCASE']
DEBUG [2020-02-26 05:21:34,989] core.sqldb.row_exists.655: Checking if guid="https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb&i=211318&r=42f28324b3b933d7d38e3560101f949a" exists in database table MARKEDRESULTS
INFO [2020-02-26 05:21:34,989] core.library.searchresults.969: Successfully marked https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb as Bad in SEARCHRESULTS.
DEBUG [2020-02-26 05:21:34,474] core.sqldb.execute.166: Executing SQL command: ['UPDATE SEARCHRESULTS SET status=? WHERE guid=? COLLATE NOCASE', ('Bad', 'https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb&i=211318&r=42f28324b3b933d7d38e3560101f949a')]
DEBUG [2020-02-26 05:21:34,474] core.sqldb.update.250: Updating status to Bad for rows that match guid:https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb in SEARCHRESULTS.
INFO [2020-02-26 05:21:34,474] core.library.searchresults.964: Marking https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb as Bad in SEARCHRESULTS.
DEBUG [2020-02-26 05:21:34,471] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM SEARCHRESULTS WHERE guid="https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb&i=211318&r=42f28324b3b933d7d38e3560101f949a" COLLATE NOCASE']
DEBUG [2020-02-26 05:21:34,471] core.sqldb.row_exists.655: Checking if guid="https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb&i=211318&r=42f28324b3b933d7d38e3560101f949a" exists in database table SEARCHRESULTS
INFO [2020-02-26 05:21:34,471] core.library.searchresults.959: Marking guid https://api.nzb.su/getnzb/7cc4236a6365414f33f3325e4981e653.nzb as Bad.
INFO [2020-02-26 05:21:34,471] core.postprocessing.failed.384: Marking guid as Bad.
WARNING [2020-02-26 05:21:34,470] core.postprocessing.default.195: Post-processing as Failed.
INFO [2020-02-26 05:21:34,467] core.library.parse_media.467: Parsing codec data from file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost.nzb.gz.
INFO [2020-02-26 05:21:34,467] core.library.parse_filename.534: Found {'year': 2018, 'resolution': '1080p', 'quality': 'BluRay', 'codec': 'x264', 'group': 'DiVULGED-xpost.nzb.gz', 'title': 'A Quiet Place'} in file name.
DEBUG [2020-02-26 05:21:34,467] core.library.parse_filename.531: Parsing directory name does not look accurate. Parsing file name.
INFO [2020-02-26 05:21:34,466] core.library.parse_filename.521: Parsing directory name for movie information: __ADMIN__.
INFO [2020-02-26 05:21:34,466] core.library.from_file.396: Gathering metadata for /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost.nzb.gz.
INFO [2020-02-26 05:21:34,466] core.postprocessing.get_movie_info.336: Movie data found locally by imdbid.
DEBUG [2020-02-26 05:21:34,466] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM MOVIES WHERE imdbid="tt6644200"']
DEBUG [2020-02-26 05:21:34,466] core.sqldb.get_movie_details.439: Retrieving details for movie tt6644200.
INFO [2020-02-26 05:21:34,465] core.postprocessing.get_movie_info.333: Searching local database by imdbid.
INFO [2020-02-26 05:21:34,465] core.postprocessing.get_movie_info.322: Found match for A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost in releases.
DEBUG [2020-02-26 05:21:34,463] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM SEARCHRESULTS WHERE title = "A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost" COLLATE NOCASE ORDER BY score DESC, size DESC']
DEBUG [2020-02-26 05:21:34,462] core.sqldb.get_single_search_result.707: Retrieving search result details for A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost.
INFO [2020-02-26 05:21:34,462] core.postprocessing.get_movie_info.319: Searching local database for release name A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost
INFO [2020-02-26 05:21:34,462] core.postprocessing.get_movie_info.303: Guid not found.
INFO [2020-02-26 05:21:34,462] core.postprocessing.get_movie_info.300: Unable to find local release info by guid.
DEBUG [2020-02-26 05:21:34,459] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM SEARCHRESULTS WHERE guid = "SABnzbd_nzo_9wy6T9" COLLATE NOCASE ORDER BY score DESC, size DESC']
DEBUG [2020-02-26 05:21:34,459] core.sqldb.get_single_search_result.707: Retrieving search result details for SABnzbd_nzo_9wy6T9.
INFO [2020-02-26 05:21:34,459] core.postprocessing.get_movie_info.295: Searching local database for guid.
INFO [2020-02-26 05:21:34,459] core.postprocessing.default.190: Gathering release information.
INFO [2020-02-26 05:21:34,459] core.postprocessing.get_movie_file.273: Largest file in directory /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost is /__ADMIN__/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost.nzb.gz, processing this file.
DEBUG [2020-02-26 05:21:34,459] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_attrib in postprocessing dir.
DEBUG [2020-02-26 05:21:34,459] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost.nzb.gz in postprocessing dir.
DEBUG [2020-02-26 05:21:34,459] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_ld0XMp in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_BvQpf6 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_Si8SwX in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_YNr_f9 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_2L8yGD in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_wWrneL in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_sGUx5c in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_GFkU6a in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_iYmuU2 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_allGbU in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_wSZ8Su in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_vTTeP_ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_mAwhC9 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_sEUOuF in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_fs63d4 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_30T3sk in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_nUwWGN in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_4TCIQT in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_XIBmmI in postprocessing dir.
DEBUG [2020-02-26 05:21:34,458] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_HtqtX5 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_taGtXl in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_XxzysU in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_1IpevO in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_2ZSOUK in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_BflwwF in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_F7myEl in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf__779Ba in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_vC_JPC in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_U8iZAV in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_4yr9E5 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_KozxcM in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_87bJPm in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_4wL790 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_dY2j0w in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_fdsKJt in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_nvmdDP in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_7WAOWQ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_qgezZo in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_lHDiL8 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,457] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_43odEx in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_VyJqRE in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_0gBNhX in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_Oy53g_ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_QYohjV in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_RgVw0y in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_pzG23x in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_uphpLZ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_1K3ubu in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_ybtCf8 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_7HAMiM in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_bSpKXH in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_JEoLkl in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_hc2XPq in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_CaIe1l in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_dIJMAi in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_lwXFFe in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_xfBmeP in postprocessing dir.
DEBUG [2020-02-26 05:21:34,456] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_wsCHL7 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_1YgUP_ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_xU0h0m in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_hcOYnc in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_9I_4_p in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_KUSJuQ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_8GTTPk in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_OGsxMJ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_jnwA6f in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf__DSD9v in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_cxRrnG in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_P6C2LY in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_1S_GZV in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_Pqgj7h in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_tokpCq in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_goCV1M in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_BB8poN in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_6TUXAK in postprocessing dir.
DEBUG [2020-02-26 05:21:34,455] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_l79V9S in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_hUgRIx in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_g1ghHN in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_Akt995 in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_9dI9Pb in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_rMeCjz in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_b3_tiQ in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_HD170g in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_GowWJm in postprocessing dir.
DEBUG [2020-02-26 05:21:34,454] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost/__ADMIN__/SABnzbd_nzf_YBoQKo in postprocessing dir.
INFO [2020-02-26 05:21:34,429] core.postprocessing.get_movie_file.247: Finding movie file.
DEBUG [2020-02-26 05:21:34,429] core.postprocessing.default.176: {'apikey': '6b5738ba2c820837d89e9dae29ef705', 'path': '/media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost', 'guid': 'SABnzbd_nzo_9wy6T9', 'mode': 'failed'}
INFO [2020-02-26 05:21:34,429] core.postprocessing.default.158: #################################
INFO [2020-02-26 05:21:34,429] core.postprocessing.default.157: Post-processing request received.
INFO [2020-02-26 05:21:34,429] core.postprocessing.default.156: #################################
WARNING [2020-02-26 05:21:34,226] core.postprocessing.default.163: Missing key apikey
INFO [2020-02-26 05:21:34,226] core.postprocessing.default.158: #################################
INFO [2020-02-26 05:21:34,226] core.postprocessing.default.157: Post-processing request received.
INFO [2020-02-26 05:21:34,226] core.postprocessing.default.156: #################################
INFO [2020-02-26 05:21:00,472] core.postprocessing.default.233: #################################
I've checked the file and it downloaded fine and is fully playable. I really dont know what im looking at with the logs.
Heres a output from another movie downloaded just after
Watcher
INFO [2020-02-26 05:51:48,686] core.postprocessing.default.232: {
INFO [2020-02-26 05:51:48,545] core.postprocessing.default.231: Post-processing complete.
INFO [2020-02-26 05:51:48,544] core.postprocessing.default.230: #################################
DEBUG [2020-02-26 05:51:47,300] core.sqldb.execute.166: Executing SQL command: ['UPDATE MOVIES SET finished_file=? WHERE imdbid=? COLLATE NOCASE', ('/media/DrivePool/Movie/A Quiet Place (2018)/A Quiet Place (2018).mkv', 'tt6644200')]
DEBUG [2020-02-26 05:51:47,300] core.sqldb.update.250: Updating finished_file to /media/DrivePool/Movie/A Quiet Place (2018)/A Quiet Place (2018).mkv for rows that match imdbid:tt6644200 in MOVIES.
INFO [2020-02-26 05:51:47,163] core.postprocessing.renamer.712: Renaming A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv to A Quiet Place (2018).mkv
DEBUG [2020-02-26 05:51:47,163] core.postprocessing.compile_path.671: Created path "A Quiet Place (2018)" from "{title} ({year})"
INFO [2020-02-26 05:51:47,084] core.postprocessing.renamer.683: ## Renaming Downloaded Files
INFO [2020-02-26 05:47:34,956] core.postprocessing.mover.878: Moving /media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv to /media/DrivePool/Movie/A Quiet Place (2018)/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv
DEBUG [2020-02-26 05:47:34,922] core.postprocessing.compile_path.671: Created path "/media/DrivePool/Movie/A Quiet Place (2018)/" from "/media/DrivePool/Movie/{title} ({year})/"
INFO [2020-02-26 05:47:34,922] core.postprocessing.mover.801: ## Moving Downloaded Files
INFO [2020-02-26 05:47:34,921] core.library.convert_to_db.590: Converting movie metadata to database structure for A Quiet Place.
DEBUG [2020-02-26 05:47:34,388] core.sqldb.execute.166: Executing SQL command: ['UPDATE MOVIES SET finished_date=?,finished_score=? WHERE imdbid=?', ('2020-02-26', 740, 'tt6644200')]
DEBUG [2020-02-26 05:47:34,388] core.sqldb.update_multiple_values.297: Updating imdbid:tt6644200 to {'finished_date': '2020-02-26', 'finished_score': 740} in MOVIES.
DEBUG [2020-02-26 05:47:33,736] core.sqldb.execute.166: Executing SQL command: ['UPDATE MOVIES SET status=? WHERE imdbid=? COLLATE NOCASE', ('Finished', 'tt6644200')]
DEBUG [2020-02-26 05:47:33,736] core.sqldb.update.250: Updating status to Finished for rows that match imdbid:tt6644200 in MOVIES.
INFO [2020-02-26 05:47:33,736] core.library.movie_status.1085: Setting MOVIES tt6644200 status to Finished.
DEBUG [2020-02-26 05:47:33,733] core.sqldb.execute.166: Executing SQL command: ['SELECT DISTINCT status FROM SEARCHRESULTS WHERE imdbid="tt6644200" AND (reject_reason IS NULL OR status <> "Available")AND type IN ("import", "nzb", "torrent", "magnet")']
DEBUG [2020-02-26 05:47:33,732] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM MOVIES WHERE imdbid="tt6644200"']
DEBUG [2020-02-26 05:47:33,732] core.sqldb.get_movie_details.439: Retrieving details for movie tt6644200.
INFO [2020-02-26 05:47:33,732] core.library.movie_status.1047: Determining appropriate status for movie tt6644200.
INFO [2020-02-26 05:47:33,732] core.postprocessing.complete.537: Setting MOVIE status.
DEBUG [2020-02-26 05:47:33,732] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM MOVIES WHERE imdbid="tt6644200"']
DEBUG [2020-02-26 05:47:33,731] core.sqldb.get_movie_details.439: Retrieving details for movie tt6644200.
DEBUG [2020-02-26 05:47:33,731] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM MOVIES WHERE imdbid="tt6644200" COLLATE NOCASE']
DEBUG [2020-02-26 05:47:33,731] core.sqldb.row_exists.655: Checking if imdbid="tt6644200" exists in database table MOVIES
INFO [2020-02-26 05:47:33,731] core.library.markedresults.1017: Successfully marked https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Finished in MARKEDRESULTS.
DEBUG [2020-02-26 05:47:33,123] core.sqldb.execute.166: Executing SQL command: ['UPDATE MARKEDRESULTS SET status=? WHERE guid=? COLLATE NOCASE', ('Finished', 'https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb')]
DEBUG [2020-02-26 05:47:33,123] core.sqldb.update.250: Updating status to Finished for rows that match guid:https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb in MARKEDRESULTS.
INFO [2020-02-26 05:47:33,123] core.library.markedresults.1012: Marking https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Finished in MARKEDRESULTS.
DEBUG [2020-02-26 05:47:33,122] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM MARKEDRESULTS WHERE guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" COLLATE NOCASE']
DEBUG [2020-02-26 05:47:33,122] core.sqldb.row_exists.655: Checking if guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" exists in database table MARKEDRESULTS
INFO [2020-02-26 05:47:33,122] core.library.searchresults.969: Successfully marked https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Finished in SEARCHRESULTS.
DEBUG [2020-02-26 05:47:32,433] core.sqldb.execute.166: Executing SQL command: ['UPDATE SEARCHRESULTS SET status=? WHERE guid=? COLLATE NOCASE', ('Finished', 'https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb')]
DEBUG [2020-02-26 05:47:32,433] core.sqldb.update.250: Updating status to Finished for rows that match guid:https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb in SEARCHRESULTS.
INFO [2020-02-26 05:47:32,433] core.library.searchresults.964: Marking https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Finished in SEARCHRESULTS.
DEBUG [2020-02-26 05:47:32,430] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM SEARCHRESULTS WHERE guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" COLLATE NOCASE']
DEBUG [2020-02-26 05:47:32,430] core.sqldb.row_exists.655: Checking if guid="https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb&i=357537&r=e6d6dbcc26d5709ee146ba63851561eb" exists in database table SEARCHRESULTS
INFO [2020-02-26 05:47:32,430] core.library.searchresults.959: Marking guid https://api.nzbplanet.net/getnzb/24be8f9250c71eb2e19ad0447c718cb8.nzb as Finished.
INFO [2020-02-26 05:47:32,430] core.postprocessing.complete.494: Marking guid as Finished.
DEBUG [2020-02-26 05:47:31,923] core.sqldb.execute.166: Executing SQL command: ['INSERT INTO POSTPROCESSED_PATHS ( path ) VALUES ( ? )', ['/media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P']]
DEBUG [2020-02-26 05:47:31,923] core.sqldb.write.193: Writing data to POSTPROCESSED_PATHS.
DEBUG [2020-02-26 05:47:31,922] core.sqldb.execute.166: Executing SQL command: ['SELECT 1 FROM POSTPROCESSED_PATHS WHERE path="/media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P" COLLATE NOCASE']
DEBUG [2020-02-26 05:47:31,922] core.sqldb.row_exists.655: Checking if path="/media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P" exists in database table POSTPROCESSED_PATHS
INFO [2020-02-26 05:47:31,922] core.postprocessing.default.198: Post-processing as Complete.
INFO [2020-02-26 05:47:31,815] core.library.parse_media.467: Parsing codec data from file /media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv.
INFO [2020-02-26 05:47:31,815] core.library.parse_filename.529: Found {'year': 2018, 'resolution': '1080p', 'quality': 'BluRay', 'codec': 'x264', 'group': 'SPARKS-4P', 'title': 'A Quiet Place', 'release_name': 'A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P'} in filename.
INFO [2020-02-26 05:47:31,815] core.library.parse_filename.521: Parsing directory name for movie information: A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.
INFO [2020-02-26 05:47:31,814] core.library.from_file.396: Gathering metadata for /media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv.
INFO [2020-02-26 05:47:31,814] core.postprocessing.get_movie_info.336: Movie data found locally by imdbid.
DEBUG [2020-02-26 05:47:31,814] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM MOVIES WHERE imdbid="tt6644200"']
DEBUG [2020-02-26 05:47:31,814] core.sqldb.get_movie_details.439: Retrieving details for movie tt6644200.
INFO [2020-02-26 05:47:31,814] core.postprocessing.get_movie_info.333: Searching local database by imdbid.
INFO [2020-02-26 05:47:31,814] core.postprocessing.get_movie_info.322: Found match for A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P in releases.
DEBUG [2020-02-26 05:47:31,811] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM SEARCHRESULTS WHERE title = "A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P" COLLATE NOCASE ORDER BY score DESC, size DESC']
DEBUG [2020-02-26 05:47:31,811] core.sqldb.get_single_search_result.707: Retrieving search result details for A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.
INFO [2020-02-26 05:47:31,811] core.postprocessing.get_movie_info.319: Searching local database for release name A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P
INFO [2020-02-26 05:47:31,811] core.postprocessing.get_movie_info.303: Guid not found.
INFO [2020-02-26 05:47:31,811] core.postprocessing.get_movie_info.300: Unable to find local release info by guid.
DEBUG [2020-02-26 05:47:31,806] core.sqldb.execute.166: Executing SQL command: ['SELECT * FROM SEARCHRESULTS WHERE guid = "SABnzbd_nzo_7HJHcG" COLLATE NOCASE ORDER BY score DESC, size DESC']
DEBUG [2020-02-26 05:47:31,806] core.sqldb.get_single_search_result.707: Retrieving search result details for SABnzbd_nzo_7HJHcG.
INFO [2020-02-26 05:47:31,806] core.postprocessing.get_movie_info.295: Searching local database for guid.
INFO [2020-02-26 05:47:31,806] core.postprocessing.default.190: Gathering release information.
INFO [2020-02-26 05:47:31,806] core.postprocessing.get_movie_file.273: Largest file in directory /media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P is /A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv, processing this file.
DEBUG [2020-02-26 05:47:31,806] core.postprocessing.get_movie_file.259: Found file /media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv in postprocessing dir.
INFO [2020-02-26 05:47:31,797] core.postprocessing.get_movie_file.247: Finding movie file.
DEBUG [2020-02-26 05:47:31,797] core.postprocessing.default.176: {'apikey': '6b5738ba2c820837d89e9dae29ef705', 'path': '/media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P', 'guid': 'SABnzbd_nzo_7HJHcG', 'mode': 'complete'}
INFO [2020-02-26 05:47:31,797] core.postprocessing.default.158: #################################
INFO [2020-02-26 05:47:31,797] core.postprocessing.default.157: Post-processing request received.
INFO [2020-02-26 05:47:31,797] core.postprocessing.default.156: #################################
WARNING [2020-02-26 05:47:30,293] core.postprocessing.default.163: Missing key apikey
INFO [2020-02-26 05:47:30,292] core.postprocessing.default.158: #################################
INFO [2020-02-26 05:47:30,292] core.postprocessing.default.157: Post-processing request received.
INFO [2020-02-26 05:47:30,292] core.postprocessing.default.156: #################################
NzbToMedia
[05:47:28] [INFO]::MAIN: Loading config from [/home/sab/scripts/nzbToMedia/autoProcessMedia.cfg]
[05:47:28] [INFO]::MAIN: Python v3.6 will reach end of life in 666 days.
[05:47:28] [INFO]::MAIN: Checking database structure...
[05:47:28] [INFO]::MAIN: Checking if git needs an update
[05:47:28] [ERROR]::MAIN: Unable to contact github, can't check for update
[05:47:28] [INFO]::MAIN: No update needed
[05:47:28] [INFO]::MAIN: nzbToMedia Version:2e7d4a58633b4b7924496ba849636bd5bb3b98cc Branch:master (Linux 4.15.0-88-generic)
[05:47:28] [INFO]::MAIN: #########################################################
[05:47:28] [INFO]::MAIN: ## ..::[nzbToMedia.py]::.. ##
[05:47:28] [INFO]::MAIN: #########################################################
[05:47:28] [INFO]::MAIN: Script triggered from SABnzbd 0.7.17+
[05:47:30] [INFO]::MAIN: Auto-detected SECTION:Watcher3
[05:47:30] [INFO]::MAIN: Calling Watcher3:movies to post-process:A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.nzb
[05:47:30] [INFO]::MAIN: Attemping imdbID lookup for A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.nzb
[05:47:30] [INFO]::MAIN: Searching folder and file names for imdbID ...
[05:47:30] [INFO]::MAIN: Searching IMDB for imdbID ...
[05:47:30] [INFO]::MAIN: Unable to determine imdbID: No api key provided for ombdapi.com.
[05:47:31] [INFO]::TRANSCODER: Checking [A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv] for corruption, please stand by ...
[05:47:31] [INFO]::TRANSCODER: SUCCESS: [A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.mkv] has no corruption.
[05:47:31] [POSTPROCESS]::WATCHER3: Starting postprocessing scan for A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.nzb
[05:51:48] [POSTPROCESS]::POSTPROCESS: Watcher3 updated status to Finished
[05:51:48] [INFO]::CLEANDIR: Directory /media/DrivePool/NZB_Download/Complete/Movie/A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P has been processed and removed ...
[05:51:48] [INFO]::MAIN: The /home/sab/scripts/nzbToMedia/nzbToWatcher3.py script completed successfully.
Changing to directory: /home/sab/scripts/nzbToMedia
-- Cleaning bytecode --
b'Removing __pycache__/\n'
b'Removing __pycache__/\n'
-- Cleaning folders: ['libs', 'core'] --
No folders to clean
Returning to directory: /usr/bin
-- Cleanup finished --
Watcher3: Successfully post-processed A.Quiet.Place.2018.1080p.BluRay.x264-SPARKS-4P.nzb!
First download is postprocessed as failed, and another release is snatched. I'm wondering if you setup apikey correctly in nzbToMedia, as you get this line: WARNING [2020-02-26 05:47:30,293] core.postprocessing.default.163: Missing key apikey
Although it looks like watcher is running postprocess anyway, looking for files in path on request params: /media/DrivePool/NZB_Download/Incomplete/A.Quiet.Place.2018.1080p.BluRay.x264-DiVULGED-xpost
Also, I wonder why you are getting postprocess request with Incomplete directory, which has no movie file, it has many other files, and one file with extension .nzb.gz, which is picked because is largest, and then postprocess think download failed because it isn't a movie file. This is the reason to have movie as snatched, because another download was started.
